[mythtv-users] 0.25 mpeg2 lossless transcoding works again! hallelujah! except...
Steven Adeff
adeffs.mythtv at gmail.com
Tue Mar 13 14:03:34 UTC 2012
On Mon, Mar 12, 2012 at 5:55 PM, Michael T. Dean
<mtdean at thirdcontact.com> wrote:
> That's a mythbackend.log. You need to look at mythtranscode.log.
>
> Note, also, that depending on when you upgraded and whether your distro
> had properly set up logging (as there were some permissions issues with
> syslog logging in Ubuntu until recently), you may have a broken syslog
> setup. See:
>
> http://www.mythtv.org/wiki/Rsyslog_Configuration
>
> Where you should likely be using "Simple rsyslog Configuration" and not
> "Templated Logging to local7 Facility". And the "commands to
> create/update the initial log files" can be used to fix any permissions
> on Ubuntu.
>
> Mike
ah! ok, I did install from mythbuntu with the correct "settings"
according to that wiki page. here is my mythtranscode output, sorry
for the page breaks, it's the best I can figure out how to do via
puTTY from work...
mythbackend:/var/log/mythtv$ more mythtranscode.log
Mar 10 17:55:46 mythbackend mythtranscode[6001]: mythtranscode version: master [
v0.25-beta-74-g5201fb9] www.mythtv.org
Mar 10 17:55:46 mythbackend mythtranscode[6001]: Enabled verbose msgs: general
Mar 10 17:55:46 mythbackend mythtranscode[6001]: Setting Log Level to LOG_INFO
Mar 10 17:55:46 mythbackend mythtranscode[6001]: Added logging to the console
Mar 10 17:55:46 mythbackend mythtranscode[6001]: Added syslogging to facility lo
cal7
Mar 10 17:55:46 mythbackend mythtranscode[6001]: Added database logging to table
logging
Mar 10 17:55:46 mythbackend mythtranscode[6001]: Setting up SIGHUP handler
Mar 10 17:55:46 mythbackend mythtranscode[6001]: Using runtime prefix = /usr
Mar 10 17:55:46 mythbackend mythtranscode[6001]: Using configuration directory =
/home/mythtv/.mythtv
Mar 10 17:55:46 mythbackend mythtranscode[6001]: Using localhost value of mythba
ckend
Mar 10 17:55:46 mythbackend mythtranscode[6001]: Testing network connectivity to
'192.168.1.151'
Mar 10 17:55:46 mythbackend mythtranscode[6001]: Starting process signal handler
Mar 10 17:55:46 mythbackend mythtranscode[6001]: Starting process manager
Mar 10 17:55:46 mythbackend mythtranscode[6001]: Starting IO manager (write)
Mar 10 17:55:46 mythbackend mythtranscode[6001]: Starting IO manager (read)
Mar 10 17:55:46 mythbackend mythtranscode[6001]: Database connection created: DB
Manager0
Mar 10 17:55:46 mythbackend mythtranscode[6001]: New DB connection, total: 1
Mar 10 17:55:46 mythbackend mythtranscode[6001]: Connected to database 'mythconv
erg' at host: 192.168.1.151
Mar 10 17:55:46 mythbackend mythtranscode[6001]: Closing DB connection named 'DB
Manager0'
Mar 10 17:55:46 mythbackend mythtranscode[6001]: Database connection created: DB
Manager1
Mar 10 17:55:46 mythbackend mythtranscode[6001]: New DB connection, total: 1
Mar 10 17:55:46 mythbackend mythtranscode[6001]: Connected to database 'mythconv
erg' at host: 192.168.1.151
Mar 10 17:55:46 mythbackend mythtranscode[6001]: Current locale EN_US
Mar 10 17:55:46 mythbackend mythtranscode[6001]: Reading locale defaults from /u
sr/share/mythtv//locales/en_us.xml
Mar 10 17:55:46 mythbackend mythtranscode[6001]: Loading en_us translation for m
odule mythfrontend
Mar 10 17:55:46 mythbackend mythtranscode[6001]: Database connection created: DB
Manager2
Mar 10 17:55:46 mythbackend mythtranscode[6001]: New DB connection, total: 2
Mar 10 17:55:46 mythbackend mythtranscode[6001]: Connected to database 'mythconv
erg' at host: 192.168.1.151
Mar 10 17:55:47 mythbackend mythtranscode[6001]: Transcoding from /media/myth/4/
tv/8784_20111118125900.mpg to /media/myth/4/tv/8784_20111118125900.mpg.tmp
Mar 10 17:55:47 mythbackend mythtranscode[6001]: Database connection created: DB
Manager3
Mar 10 17:55:47 mythbackend mythtranscode[6001]: New DB connection, total: 3
Mar 10 17:55:47 mythbackend mythtranscode[6001]: Connected to database 'mythconv
erg' at host: 192.168.1.151
Mar 10 17:55:47 mythbackend mythtranscode[6001]: MythCoreContext: Connecting to
backend server: 192.168.1.151:6543 (try 1 of 1)
Mar 10 17:55:48 mythbackend mythtranscode[6001]: AFD: Opened codec 0xffffffffb3b
aa9e0, id(MPEG2VIDEO) type(Video)
Mar 10 17:55:48 mythbackend mythtranscode[6001]: AFD: codec AC3 has 6 channels
Mar 10 17:55:48 mythbackend mythtranscode[6001]: AFD: Opened codec 0xffffffffb3b
aaff0, id(AC3) type(Audio)
Mar 10 17:55:48 mythbackend mythtranscode[6001]: AudioPlayer: Enabling Audio
Mar 10 17:55:50 mythbackend mythtranscode[6001]: Honoring the cutlist while tran
scoding
Mar 10 17:55:50 mythbackend mythtranscode[6001]: Cutlist : 0-3016,21417-2
7416,43765-50514,63100-70028,84202-90776,97188-102585,110911-117106
Mar 10 17:55:50 mythbackend mythtranscode[6001]: Original Length: 117106 frames
Mar 10 17:55:50 mythbackend mythtranscode[6001]: New Length : 76248 frames
Mar 10 17:55:50 mythbackend mythtranscode[6001]: Found video height of 1088. Th
is is unusual and more than likely the video is actually 1080 so mythtranscode w
ill treat it as such.
Mar 10 17:55:50 mythbackend mythtranscode[6001]: Transcode: Looking for autodete
ct profile: Autodetect from 1080i
Mar 10 17:55:50 mythbackend mythtranscode[6001]: Transcode: Couldn't find profil
e for : MPEG-2
Mar 10 17:55:50 mythbackend mythtranscode[6001]: Transcoding aborted, no profile
found.
Mar 10 17:55:54 mythbackend mythtranscode[6001]: MythSocket(8c305e0:27): readStr
ingList: Error, timed out after 7000 ms.
Mar 10 17:55:54 mythbackend mythtranscode[6001]: Protocol version check failure.
#012#011#011#011The response to MYTH_PROTO_VERSION was empty.#012#011#011#011Thi
s happens when the backend is too busy to respond,#012#011#011#011or has deadloc
ked in due to bugs or hardware failure.
Mar 10 17:55:54 mythbackend mythtranscode[6001]: Transcoding /media/myth/4/tv/87
84_20111118125900.mpg failed
Mar 10 17:55:54 mythbackend mythtranscode[6001]: Transcode: delete old file: wai
ting while program is in use.
Mar 10 17:55:54 mythbackend mythtranscode[6001]: Transcode: program is no longer
in use.
Mar 10 17:55:54 mythbackend mythtranscode[6001]: Deleting /media/myth/4/tv/8784_
20111118125900.mpg.tmp
Mar 10 17:55:54 mythbackend mythtranscode[6001]: Requesting delete for file 'myt
h://Default@192.168.1.151:6543/8784_20111118125900.mpg.tmp'.
Mar 10 17:55:54 mythbackend mythtranscode[6001]: MythCoreContext: Connecting to
backend server: 192.168.1.151:6543 (try 1 of 1)
Mar 10 17:56:01 mythbackend mythtranscode[6091]: mythtranscode version: master [
v0.25-beta-74-g5201fb9] www.mythtv.org
Mar 10 17:56:01 mythbackend mythtranscode[6091]: Enabled verbose msgs: general
Mar 10 17:56:01 mythbackend mythtranscode[6091]: Setting Log Level to LOG_INFO
Mar 10 17:56:01 mythbackend mythtranscode[6091]: Added logging to the console
Mar 10 17:56:01 mythbackend mythtranscode[6091]: Added syslogging to facility lo
cal7
Mar 10 17:56:01 mythbackend mythtranscode[6091]: Added database logging to table
logging
Mar 10 17:56:01 mythbackend mythtranscode[6091]: Setting up SIGHUP handler
Mar 10 17:56:01 mythbackend mythtranscode[6091]: Using runtime prefix = /usr
Mar 10 17:56:01 mythbackend mythtranscode[6091]: Using configuration directory =
/home/mythtv/.mythtv
Mar 10 17:56:01 mythbackend mythtranscode[6091]: Using localhost value of mythba
ckend
Mar 10 17:56:01 mythbackend mythtranscode[6091]: Testing network connectivity to
'192.168.1.151'
Mar 10 17:56:01 mythbackend mythtranscode[6091]: Starting process manager
Mar 10 17:56:01 mythbackend mythtranscode[6091]: Starting IO manager (read)
Mar 10 17:56:01 mythbackend mythtranscode[6091]: Starting IO manager (write)
Mar 10 17:56:01 mythbackend mythtranscode[6091]: Starting process signal handler
Mar 10 17:56:01 mythbackend mythtranscode[6091]: Database connection created: DB
Manager0
Mar 10 17:56:01 mythbackend mythtranscode[6091]: New DB connection, total: 1
Mar 10 17:56:01 mythbackend mythtranscode[6091]: Connected to database 'mythconv
erg' at host: 192.168.1.151
Mar 10 17:56:01 mythbackend mythtranscode[6091]: Closing DB connection named 'DB
Manager0'
Mar 10 17:56:01 mythbackend mythtranscode[6091]: Database connection created: DB
Manager1
Mar 10 17:56:01 mythbackend mythtranscode[6091]: New DB connection, total: 1
Mar 10 17:56:01 mythbackend mythtranscode[6091]: Connected to database 'mythconv
erg' at host: 192.168.1.151
Mar 10 17:56:01 mythbackend mythtranscode[6091]: Current locale EN_US
Mar 10 17:56:01 mythbackend mythtranscode[6091]: Reading locale defaults from /u
sr/share/mythtv//locales/en_us.xml
Mar 10 17:56:01 mythbackend mythtranscode[6091]: Loading en_us translation for m
odule mythfrontend
Mar 10 17:56:01 mythbackend mythtranscode[6091]: Transcoding from /media/myth/4/
tv/8784_20111118125900.mpg to /media/myth/4/tv/8784_20111118125900.mpg.tmp
Mar 10 17:56:01 mythbackend mythtranscode[6091]: Database connection created: DB
Manager2
Mar 10 17:56:01 mythbackend mythtranscode[6091]: New DB connection, total: 2
Mar 10 17:56:01 mythbackend mythtranscode[6091]: Connected to database 'mythconv
erg' at host: 192.168.1.151
Mar 10 17:56:01 mythbackend mythtranscode[6091]: Database connection created: DB
Manager3
Mar 10 17:56:01 mythbackend mythtranscode[6091]: New DB connection, total: 3
Mar 10 17:56:01 mythbackend mythtranscode[6091]: Connected to database 'mythconv
erg' at host: 192.168.1.151
Mar 10 17:56:01 mythbackend mythtranscode[6091]: MythCoreContext: Connecting to
backend server: 192.168.1.151:6543 (try 1 of 1)
Mar 10 17:56:01 mythbackend mythtranscode[6091]: AFD: Opened codec 0xffffffffb1f
3e7e0, id(MPEG2VIDEO) type(Video)
Mar 10 17:56:01 mythbackend mythtranscode[6091]: AFD: codec AC3 has 6 channels
Mar 10 17:56:01 mythbackend mythtranscode[6091]: AFD: Opened codec 0xffffffffb1f
3ef70, id(AC3) type(Audio)
Mar 10 17:56:01 mythbackend mythtranscode[6091]: AudioPlayer: Enabling Audio
Mar 10 17:56:01 mythbackend mythtranscode[6091]: Honoring the cutlist while tran
scoding
Mar 10 17:56:01 mythbackend mythtranscode[6091]: Cutlist : 0-3016,21417-2
7416,43765-50514,63100-70028,84202-90776,97188-102585,110911-117106
Mar 10 17:56:01 mythbackend mythtranscode[6091]: Original Length: 117106 frames
Mar 10 17:56:01 mythbackend mythtranscode[6091]: New Length : 76248 frames
Mar 10 17:56:01 mythbackend mythtranscode[6091]: Found video height of 1088. Th
is is unusual and more than likely the video is actually 1080 so mythtranscode w
ill treat it as such.
Mar 10 17:56:01 mythbackend mythtranscode[6091]: Transcode: Looking for autodete
ct profile: Autodetect from 1080i
Mar 10 17:56:01 mythbackend mythtranscode[6091]: Transcode: Couldn't find profil
e for : MPEG-2
Mar 10 17:56:01 mythbackend mythtranscode[6091]: Transcoding aborted, no profile
found.
Mar 10 17:56:01 mythbackend mythtranscode[6001]: MythSocket(ffffffffb05d5b10:22)
: readStringList: Error, timed out after 7000 ms.
Mar 10 17:56:01 mythbackend mythtranscode[6001]: Protocol version check failure.
#012#011#011#011The response to MYTH_PROTO_VERSION was empty.#012#011#011#011Thi
s happens when the backend is too busy to respond,#012#011#011#011or has deadloc
ked in due to bugs or hardware failure.
Mar 10 17:56:01 mythbackend mythtranscode[6001]: Deleting file '/media/myth/4/tv
/8784_20111118125900.mpg.tmp'.
Mar 10 17:56:01 mythbackend mythtranscode[6001]: MythCoreContext: Connecting to
backend server: 192.168.1.151:6543 (try 1 of 1)
Mar 10 17:56:01 mythbackend mythtranscode[6001]: Waiting for threads to exit.
Mar 10 17:56:02 mythbackend mythtranscode[6091]: MythSocket(9ca4ce8:27): readStr
ingList: Connection died (select).
Mar 10 17:56:02 mythbackend mythtranscode[6091]: Protocol version check failure.
#012#011#011#011The response to MYTH_PROTO_VERSION was empty.#012#011#011#011Thi
s happens when the backend is too busy to respond,#012#011#011#011or has deadloc
ked in due to bugs or hardware failure.
Mar 10 17:56:02 mythbackend mythtranscode[6091]: Transcoding /media/myth/4/tv/87
84_20111118125900.mpg failed
Mar 10 17:56:02 mythbackend mythtranscode[6091]: Transcode: delete old file: wai
ting while program is in use.
Mar 10 17:56:02 mythbackend mythtranscode[6091]: Transcode: program is no longer
in use.
Mar 10 17:56:02 mythbackend mythtranscode[6091]: Deleting /media/myth/4/tv/8784_
20111118125900.mpg.tmp
Mar 10 17:56:02 mythbackend mythtranscode[6091]: Requesting delete for file 'myt
h://Default@192.168.1.151:6543/8784_20111118125900.mpg.tmp'.
Mar 10 17:56:02 mythbackend mythtranscode[6091]: MythCoreContext: Connecting to
backend server: 192.168.1.151:6543 (try 1 of 1)
Mar 10 17:56:02 mythbackend mythtranscode[6091]: Connection to master server tim
ed out.#012#011#011#011Either the server is down or the master server settings#0
12#011#011#011in mythtv-settings does not contain the proper IP address
Mar 10 17:56:02 mythbackend mythtranscode[6091]: Deleting file '/media/myth/4/tv
/8784_20111118125900.mpg.tmp'.
Mar 10 17:56:02 mythbackend mythtranscode[6091]: Waiting for threads to exit.
Mar 10 17:56:02 mythbackend mythtranscode[6001]: MythSocket(8c305e0:22): readStr
ingList: Connection died (select).
Mar 10 17:56:02 mythbackend mythtranscode[6001]: Protocol version check failure.
#012#011#011#011The response to MYTH_PROTO_VERSION was empty.#012#011#011#011Thi
s happens when the backend is too busy to respond,#012#011#011#011or has deadloc
ked in due to bugs or hardware failure.
Mar 10 17:56:02 mythbackend mythtranscode[6091]: MythCoreContext: Connecting to
backend server: 192.168.1.151:6543 (try 1 of 1)
Mar 10 17:56:02 mythbackend mythtranscode[6091]: Connection to master server tim
ed out.#012#011#011#011Either the server is down or the master server settings#0
12#011#011#011in mythtv-settings does not contain the proper IP address
Mar 10 17:56:03 mythbackend mythtranscode[6001]: Closing DB connection named 'DB
Manager2'
Mar 10 17:56:03 mythbackend mythtranscode[6001]: Closing DB connection named 'DB
Manager3'
Mar 10 17:56:03 mythbackend mythtranscode[6001]: Closing DB connection named 'DB
Manager1'
Mar 10 17:56:03 mythbackend mythtranscode[6091]: Closing DB connection named 'DB
Manager2'
Mar 10 17:56:03 mythbackend mythtranscode[6091]: Closing DB connection named 'DB
Manager3'
Mar 10 17:56:03 mythbackend mythtranscode[6091]: Closing DB connection named 'DB
Manager1'
Mar 11 20:00:46 mythbackend mythtranscode[18046]: C thread_unknown mythcommandli
neparser.cpp:2534 (ConfigureLogging) mythtranscode version: master [v0.25-beta-8
8-g7862c79] www.mythtv.org
Mar 11 20:00:46 mythbackend mythtranscode[18046]: N thread_unknown mythcommandli
neparser.cpp:2536 (ConfigureLogging) Enabled verbose msgs: general
Mar 11 20:00:46 mythbackend mythtranscode[18046]: N thread_unknown logging.cpp:1
170 (logStart) Setting Log Level to LOG_INFO
Mar 11 20:00:46 mythbackend mythtranscode[18046]: I thread_unknown logging.cpp:2
29 (FileLogger) Added logging to the console
Mar 11 20:00:46 mythbackend mythtranscode[18046]: I thread_unknown logging.cpp:3
69 (SyslogLogger) Added syslogging to facility local7
Mar 11 20:00:46 mythbackend mythtranscode[18046]: I thread_unknown logging.cpp:4
25 (DatabaseLogger) Added database logging to table logging
Mar 11 20:00:46 mythbackend mythtranscode[18046]: N thread_unknown logging.cpp:1
209 (logStart) Setting up SIGHUP handler
Mar 11 20:00:46 mythbackend mythtranscode[18046]: N thread_unknown mythdirs.cpp:
51 (InitializeMythDirs) Using runtime prefix = /usr
Mar 11 20:00:46 mythbackend mythtranscode[18046]: N thread_unknown mythdirs.cpp:
64 (InitializeMythDirs) Using configuration directory = /home/mythtv/.mythtv
Mar 11 20:00:46 mythbackend mythtranscode[18046]: I CoreContext mythcontext.cpp:
481 (LoadDatabaseSettings) Using localhost value of mythbackend
Mar 11 20:00:46 mythbackend mythtranscode[18046]: I CoreContext mythcontext.cpp:
608 (TestDBconnection) Testing network connectivity to '192.168.1.151'
Mar 11 20:00:46 mythbackend mythtranscode[18046]: I SystemManager system-unix.cp
p:263 (run) Starting process manager
Mar 11 20:00:46 mythbackend mythtranscode[18046]: I SystemSignalManager system-u
nix.cpp:485 (run) Starting process signal handler
Mar 11 20:00:46 mythbackend mythtranscode[18046]: I SystemIOHandlerR system-unix
.cpp:90 (run) Starting IO manager (read)
Mar 11 20:00:46 mythbackend mythtranscode[18046]: I SystemIOHandlerW system-unix
.cpp:90 (run) Starting IO manager (write)
Mar 11 20:00:46 mythbackend mythtranscode[18046]: I CoreContext mythdbcon.cpp:75
(MSqlDatabase) Database connection created: DBManager0
Mar 11 20:00:46 mythbackend mythtranscode[18046]: I CoreContext mythdbcon.cpp:29
8 (popConnection) New DB connection, total: 1
Mar 11 20:00:46 mythbackend mythtranscode[18046]: I CoreContext mythdbcon.cpp:17
9 (OpenDatabase) Connected to database 'mythconverg' at host: 192.168.1.151
Mar 11 20:00:46 mythbackend mythtranscode[18046]: I CoreContext mythdbcon.cpp:45
3 (CloseDatabases) Closing DB connection named 'DBManager0'
Mar 11 20:00:46 mythbackend mythtranscode[18046]: I CoreContext mythdbcon.cpp:75
(MSqlDatabase) Database connection created: DBManager1
Mar 11 20:00:46 mythbackend mythtranscode[18046]: I CoreContext mythdbcon.cpp:29
8 (popConnection) New DB connection, total: 1
Mar 11 20:00:46 mythbackend mythtranscode[18046]: I CoreContext mythdbcon.cpp:17
9 (OpenDatabase) Connected to database 'mythconverg' at host: 192.168.1.151
Mar 11 20:00:46 mythbackend mythtranscode[18046]: I CoreContext mythcorecontext.
cpp:1272 (SaveLocaleDefaults) Current locale EN_US
Mar 11 20:00:46 mythbackend mythtranscode[18046]: N CoreContext mythlocale.cpp:1
10 (LoadDefaultsFromXML) Reading locale defaults from /usr/share/mythtv//locales
/en_us.xml
Mar 11 20:00:46 mythbackend mythtranscode[18046]: I CoreContext mythtranslation.
cpp:66 (load) Loading en_us translation for module mythfrontend
Mar 11 20:00:46 mythbackend mythtranscode[18046]: N CoreContext main.cpp:495 (ma
in) Transcoding from /media/myth/1/tv/8865_20120311150000.mpg to /media/myth/1/t
v/8865_20120311150000.mpg.tmp
Mar 11 20:00:47 mythbackend mythtranscode[18046]: I DBLogger mythdbcon.cpp:75 (M
SqlDatabase) Database connection created: DBManager2
Mar 11 20:00:47 mythbackend mythtranscode[18046]: I DBLogger mythdbcon.cpp:298 (
popConnection) New DB connection, total: 2
Mar 11 20:00:47 mythbackend mythtranscode[18046]: I DBLogger mythdbcon.cpp:179 (
OpenDatabase) Connected to database 'mythconverg' at host: 192.168.1.151
Mar 11 20:00:47 mythbackend mythtranscode[18046]: I ProgramInfoUpdater mythdbcon
.cpp:75 (MSqlDatabase) Database connection created: DBManager3
Mar 11 20:00:47 mythbackend mythtranscode[18046]: I ProgramInfoUpdater mythdbcon
.cpp:298 (popConnection) New DB connection, total: 3
Mar 11 20:00:47 mythbackend mythtranscode[18046]: I ProgramInfoUpdater mythdbcon
.cpp:179 (OpenDatabase) Connected to database 'mythconverg' at host: 192.168.1.1
51
Mar 11 20:00:47 mythbackend mythtranscode[18046]: I CoreContext avformatdecoder.
cpp:2100 (ScanStreams) AFD: Opened codec 0x91bf8d0, id(MPEG2VIDEO) type(Video)
Mar 11 20:00:47 mythbackend mythtranscode[18046]: I CoreContext avformatdecoder.
cpp:1958 (ScanStreams) AFD: codec AC3 has 6 channels
Mar 11 20:00:47 mythbackend mythtranscode[18046]: I CoreContext avformatdecoder.
cpp:2100 (ScanStreams) AFD: Opened codec 0x91d8dd0, id(AC3) type(Audio)
Mar 11 20:00:47 mythbackend mythtranscode[18046]: I CoreContext avformatdecoder.
cpp:1958 (ScanStreams) AFD: codec AC3 has 2 channels
Mar 11 20:00:47 mythbackend mythtranscode[18046]: I CoreContext avformatdecoder.
cpp:2100 (ScanStreams) AFD: Opened codec 0x915a7c0, id(AC3) type(Audio)
Mar 11 20:00:47 mythbackend mythtranscode[18046]: I ProgramInfoUpdater mythcorec
ontext.cpp:366 (ConnectCommandSocket) MythCoreContext: Connecting to backend ser
ver: 192.168.1.151:6543 (try 1 of 1)
Mar 11 20:00:47 mythbackend mythtranscode[18046]: N CoreContext audioplayer.cpp:
167 (ReinitAudio) AudioPlayer: Enabling Audio
Mar 11 20:00:47 mythbackend mythtranscode[18046]: I ProgramInfoUpdater mythcorec
ontext.cpp:1173 (CheckProtoVersion) Using protocol version 72
Mar 11 20:00:48 mythbackend mythtranscode[18046]: I CoreContext transcode.cpp:91
5 (TranscodeFile) Honoring the cutlist while transcoding
Mar 11 20:00:48 mythbackend mythtranscode[18046]: I CoreContext transcode.cpp:94
8 (TranscodeFile) Cutlist : 267226-373958
Mar 11 20:00:48 mythbackend mythtranscode[18046]: I CoreContext transcode.cpp:95
0 (TranscodeFile) Original Length: 373958 frames
Mar 11 20:00:48 mythbackend mythtranscode[18046]: I CoreContext transcode.cpp:95
2 (TranscodeFile) New Length : 267226 frames
Mar 11 20:00:48 mythbackend mythtranscode[18046]: N CoreContext transcode.cpp:98
0 (TranscodeFile) Found video height of 1088. This is unusual and more than lik
ely the video is actually 1080 so mythtranscode will treat it as such.
Mar 11 20:00:48 mythbackend mythtranscode[18046]: N CoreContext transcode.cpp:73
9 (GetProfile) Transcode: Looking for autodetect profile: Autodetect from 1080i
Mar 11 20:00:48 mythbackend mythtranscode[18046]: E CoreContext transcode.cpp:75
7 (GetProfile) Transcode: Couldn't find profile for : MPEG-2
Mar 11 20:00:48 mythbackend mythtranscode[18046]: E CoreContext transcode.cpp:11
78 (TranscodeFile) Transcoding aborted, no profile found.
Mar 11 20:00:49 mythbackend mythtranscode[18046]: E CoreContext main.cpp:636 (ma
in) Transcoding /media/myth/1/tv/8865_20120311150000.mpg failed
Mar 11 20:00:49 mythbackend mythtranscode[18046]: N CoreContext main.cpp:730 (Wa
itToDelete) Transcode: delete old file: waiting while program is in use.
Mar 11 20:00:49 mythbackend mythtranscode[18046]: N CoreContext main.cpp:762 (Wa
itToDelete) Transcode: program is no longer in use.
Mar 11 20:00:49 mythbackend mythtranscode[18046]: N CoreContext main.cpp:994 (Co
mpleteJob) Deleting /media/myth/1/tv/8865_20120311150000.mpg.tmp
Mar 11 20:00:49 mythbackend mythtranscode[18046]: N CoreContext main.cpp:661 (tr
ansUnlink) Requesting delete for file 'myth://Default@192.168.1.151:6543/8865_20
120311150000.mpg.tmp'.
Mar 11 20:00:49 mythbackend mythtranscode[18046]: N CoreContext main.cpp:667 (tr
ansUnlink) Deleting file '/media/myth/1/tv/8865_20120311150000.mpg.tmp'.
Mar 11 20:00:49 mythbackend mythtranscode[18046]: I CoreContext mythcontext.cpp:
1115 (~MythContext) Waiting for threads to exit.
Mar 11 20:00:50 mythbackend mythtranscode[18046]: I DBLogger mythdbcon.cpp:453 (
CloseDatabases) Closing DB connection named 'DBManager2'
Mar 11 20:00:50 mythbackend mythtranscode[18046]: I PT0 mythdbcon.cpp:453 (Close
Databases) Closing DB connection named 'DBManager3'
Mar 11 20:00:50 mythbackend mythtranscode[18046]: I CoreContext mythdbcon.cpp:45
3 (CloseDatabases) Closing DB connection named 'DBManager1'
Mar 12 19:28:59 mythbackend mythtranscode[21955]: C thread_unknown mythcommandli
neparser.cpp:2534 (ConfigureLogging) mythtranscode version: master [v0.25-beta-8
8-g7862c79] www.mythtv.org
Mar 12 19:28:59 mythbackend mythtranscode[21955]: N thread_unknown mythcommandli
neparser.cpp:2536 (ConfigureLogging) Enabled verbose msgs: general
Mar 12 19:28:59 mythbackend mythtranscode[21955]: N thread_unknown logging.cpp:1
170 (logStart) Setting Log Level to LOG_INFO
Mar 12 19:28:59 mythbackend mythtranscode[21955]: I thread_unknown logging.cpp:2
29 (FileLogger) Added logging to the console
Mar 12 19:28:59 mythbackend mythtranscode[21955]: I thread_unknown logging.cpp:3
69 (SyslogLogger) Added syslogging to facility local7
Mar 12 19:28:59 mythbackend mythtranscode[21955]: I thread_unknown logging.cpp:4
25 (DatabaseLogger) Added database logging to table logging
Mar 12 19:28:59 mythbackend mythtranscode[21955]: N thread_unknown logging.cpp:1
209 (logStart) Setting up SIGHUP handler
Mar 12 19:28:59 mythbackend mythtranscode[21955]: N thread_unknown mythdirs.cpp:
51 (InitializeMythDirs) Using runtime prefix = /usr
Mar 12 19:28:59 mythbackend mythtranscode[21955]: N thread_unknown mythdirs.cpp:
64 (InitializeMythDirs) Using configuration directory = /home/mythtv/.mythtv
Mar 12 19:28:59 mythbackend mythtranscode[21955]: I CoreContext mythcontext.cpp:
481 (LoadDatabaseSettings) Using localhost value of mythbackend
Mar 12 19:28:59 mythbackend mythtranscode[21955]: I CoreContext mythcontext.cpp:
608 (TestDBconnection) Testing network connectivity to '192.168.1.151'
Mar 12 19:28:59 mythbackend mythtranscode[21955]: I SystemSignalManager system-u
nix.cpp:485 (run) Starting process signal handler
Mar 12 19:28:59 mythbackend mythtranscode[21955]: I SystemManager system-unix.cp
p:263 (run) Starting process manager
Mar 12 19:28:59 mythbackend mythtranscode[21955]: I SystemIOHandlerR system-unix
.cpp:90 (run) Starting IO manager (read)
Mar 12 19:28:59 mythbackend mythtranscode[21955]: I SystemIOHandlerW system-unix
.cpp:90 (run) Starting IO manager (write)
Mar 12 19:29:00 mythbackend mythtranscode[21955]: I CoreContext mythdbcon.cpp:75
(MSqlDatabase) Database connection created: DBManager0
Mar 12 19:29:00 mythbackend mythtranscode[21955]: I CoreContext mythdbcon.cpp:29
8 (popConnection) New DB connection, total: 1
Mar 12 19:29:00 mythbackend mythtranscode[21955]: I CoreContext mythdbcon.cpp:17
9 (OpenDatabase) Connected to database 'mythconverg' at host: 192.168.1.151
Mar 12 19:29:00 mythbackend mythtranscode[21955]: I CoreContext mythdbcon.cpp:45
3 (CloseDatabases) Closing DB connection named 'DBManager0'
Mar 12 19:29:00 mythbackend mythtranscode[21955]: I CoreContext mythdbcon.cpp:75
(MSqlDatabase) Database connection created: DBManager1
Mar 12 19:29:00 mythbackend mythtranscode[21955]: I CoreContext mythdbcon.cpp:29
8 (popConnection) New DB connection, total: 1
Mar 12 19:29:00 mythbackend mythtranscode[21955]: I CoreContext mythdbcon.cpp:17
9 (OpenDatabase) Connected to database 'mythconverg' at host: 192.168.1.151
Mar 12 19:29:00 mythbackend mythtranscode[21955]: I CoreContext mythcorecontext.
cpp:1272 (SaveLocaleDefaults) Current locale EN_US
Mar 12 19:29:00 mythbackend mythtranscode[21955]: N CoreContext mythlocale.cpp:1
10 (LoadDefaultsFromXML) Reading locale defaults from /usr/share/mythtv//locales
/en_us.xml
Mar 12 19:29:00 mythbackend mythtranscode[21955]: I CoreContext mythtranslation.
cpp:66 (load) Loading en_us translation for module mythfrontend
Mar 12 19:29:00 mythbackend mythtranscode[21955]: I DBLogger mythdbcon.cpp:75 (M
SqlDatabase) Database connection created: DBManager2
Mar 12 19:29:00 mythbackend mythtranscode[21955]: I DBLogger mythdbcon.cpp:298 (
popConnection) New DB connection, total: 2
Mar 12 19:29:00 mythbackend mythtranscode[21955]: N CoreContext main.cpp:495 (ma
in) Transcoding from /media/myth/1/tv/8865_20120311150000.mpg to /media/myth/1/t
v/8865_20120311150000.mpg.tmp
Mar 12 19:29:00 mythbackend mythtranscode[21955]: I DBLogger mythdbcon.cpp:179 (
OpenDatabase) Connected to database 'mythconverg' at host: 192.168.1.151
Mar 12 19:29:00 mythbackend mythtranscode[21955]: I ProgramInfoUpdater mythdbcon
.cpp:75 (MSqlDatabase) Database connection created: DBManager3
Mar 12 19:29:00 mythbackend mythtranscode[21955]: I ProgramInfoUpdater mythdbcon
.cpp:298 (popConnection) New DB connection, total: 3
Mar 12 19:29:00 mythbackend mythtranscode[21955]: I ProgramInfoUpdater mythdbcon
.cpp:179 (OpenDatabase) Connected to database 'mythconverg' at host: 192.168.1.1
51
Mar 12 19:29:00 mythbackend mythtranscode[21955]: I ProgramInfoUpdater mythcorec
ontext.cpp:366 (ConnectCommandSocket) MythCoreContext: Connecting to backend ser
ver: 192.168.1.151:6543 (try 1 of 1)
Mar 12 19:29:00 mythbackend mythtranscode[21955]: I ProgramInfoUpdater mythcorec
ontext.cpp:1173 (CheckProtoVersion) Using protocol version 72
Mar 12 19:29:00 mythbackend mythtranscode[21955]: I CoreContext avformatdecoder.
cpp:2100 (ScanStreams) AFD: Opened codec 0xffffffffb5480f90, id(MPEG2VIDEO) type
(Video)
Mar 12 19:29:00 mythbackend mythtranscode[21955]: I CoreContext avformatdecoder.
cpp:1958 (ScanStreams) AFD: codec AC3 has 6 channels
Mar 12 19:29:00 mythbackend mythtranscode[21955]: I CoreContext avformatdecoder.
cpp:2100 (ScanStreams) AFD: Opened codec 0xffffffffb5481570, id(AC3) type(Audio)
Mar 12 19:29:00 mythbackend mythtranscode[21955]: I CoreContext avformatdecoder.
cpp:1958 (ScanStreams) AFD: codec AC3 has 2 channels
Mar 12 19:29:00 mythbackend mythtranscode[21955]: I CoreContext avformatdecoder.
cpp:2100 (ScanStreams) AFD: Opened codec 0xffffffffb5481d00, id(AC3) type(Audio)
Mar 12 19:29:00 mythbackend mythtranscode[21955]: N CoreContext audioplayer.cpp:
167 (ReinitAudio) AudioPlayer: Enabling Audio
Mar 12 19:29:01 mythbackend mythtranscode[21955]: I CoreContext transcode.cpp:91
5 (TranscodeFile) Honoring the cutlist while transcoding
Mar 12 19:29:01 mythbackend mythtranscode[21955]: I CoreContext transcode.cpp:94
8 (TranscodeFile) Cutlist : 267226-373958
Mar 12 19:29:01 mythbackend mythtranscode[21955]: I CoreContext transcode.cpp:95
0 (TranscodeFile) Original Length: 373958 frames
Mar 12 19:29:01 mythbackend mythtranscode[21955]: I CoreContext transcode.cpp:95
2 (TranscodeFile) New Length : 267226 frames
Mar 12 19:29:01 mythbackend mythtranscode[21955]: N CoreContext transcode.cpp:98
0 (TranscodeFile) Found video height of 1088. This is unusual and more than lik
ely the video is actually 1080 so mythtranscode will treat it as such.
Mar 12 19:29:01 mythbackend mythtranscode[21955]: N CoreContext transcode.cpp:73
9 (GetProfile) Transcode: Looking for autodetect profile: Autodetect from 1080i
Mar 12 19:29:01 mythbackend mythtranscode[21955]: E CoreContext transcode.cpp:75
7 (GetProfile) Transcode: Couldn't find profile for : MPEG-2
Mar 12 19:29:01 mythbackend mythtranscode[21955]: E CoreContext transcode.cpp:11
78 (TranscodeFile) Transcoding aborted, no profile found.
Mar 12 19:29:01 mythbackend mythtranscode[21955]: E CoreContext main.cpp:636 (ma
in) Transcoding /media/myth/1/tv/8865_20120311150000.mpg failed
Mar 12 19:29:01 mythbackend mythtranscode[21955]: N CoreContext main.cpp:730 (Wa
itToDelete) Transcode: delete old file: waiting while program is in use.
Mar 12 19:29:01 mythbackend mythtranscode[21955]: N CoreContext main.cpp:762 (Wa
itToDelete) Transcode: program is no longer in use.
Mar 12 19:29:01 mythbackend mythtranscode[21955]: N CoreContext main.cpp:994 (Co
mpleteJob) Deleting /media/myth/1/tv/8865_20120311150000.mpg.tmp
Mar 12 19:29:01 mythbackend mythtranscode[21955]: N CoreContext main.cpp:661 (tr
ansUnlink) Requesting delete for file 'myth://Default@192.168.1.151:6543/8865_20
120311150000.mpg.tmp'.
Mar 12 19:29:01 mythbackend mythtranscode[21955]: N CoreContext main.cpp:667 (tr
ansUnlink) Deleting file '/media/myth/1/tv/8865_20120311150000.mpg.tmp'.
Mar 12 19:29:01 mythbackend mythtranscode[21955]: I CoreContext mythcontext.cpp:
1115 (~MythContext) Waiting for threads to exit.
Mar 12 19:29:02 mythbackend mythtranscode[21955]: I DBLogger mythdbcon.cpp:453 (
CloseDatabases) Closing DB connection named 'DBManager2'
Mar 12 19:29:02 mythbackend mythtranscode[21955]: I PT0 mythdbcon.cpp:453 (Close
Databases) Closing DB connection named 'DBManager3'
Mar 12 19:29:02 mythbackend mythtranscode[21955]: I CoreContext mythdbcon.cpp:45
3 (CloseDatabases) Closing DB connection named 'DBManager1'
--
Steve
http://www.mythtv.org/wiki/User:Steveadeff
Before you ask, read the FAQ!
http://www.mythtv.org/wiki/Frequently_Asked_Questions
then search the Wiki, and this list,
http://www.gossamer-threads.com/lists/mythtv/
Mailinglist etiquette - http://www.mythtv.org/wiki/Mailing_List_etiquette
More information about the mythtv-users
mailing list