2010-09-19 16:50:14.427 mythbackend version: trunk [26334] www.mythtv.org
2010-09-19 16:50:14.427 Using runtime prefix = /usr/local
2010-09-19 16:50:14.450 Using configuration directory = /home/mythtv/.mythtv
2010-09-19 16:50:14.462 Empty LocalHostName.
2010-09-19 16:50:14.472 Using localhost value of casper
2010-09-19 16:50:14.484 Testing network connectivity to '192.168.123.3'
2010-09-19 16:50:14.495 Launching: ping -t 3 -c 1  192.168.123.3  >/dev/null 2>&1
2010-09-19 16:50:14.507 PID 9612: launched
2010-09-19 16:50:14.507 Starting reaper thread
2010-09-19 16:50:14.628 PID 9612: exited: status=0, result=0
2010-09-19 16:50:14.646 New DB connection, total: 1
2010-09-19 16:50:14.654 Connected to database 'mythconverg' at host: 192.168.123.3
2010-09-19 16:50:14.661 Closing DB connection named 'DBManager0'
2010-09-19 16:50:14.673 Current locale en_US
2010-09-19 16:50:14.684 Reading locale defaults from /usr/local/share/mythtv//locales/en_us.xml
2010-09-19 16:50:14.696 Connected to database 'mythconverg' at host: 192.168.123.3
2010-09-19 16:50:14.712 Current MythTV Schema Version (DBSchemaVer): 1263
2010-09-19 16:50:14.721 ThreadPool:HTTP: Initial 1, Max 5, Timeout 60000
2010-09-19 16:50:14.737 Enabling Upnpmedia rebuild thread.
2010-09-19 16:50:15.943 MythBackend: Starting up as the master server.
2010-09-19 16:50:15.953 New DB connection, total: 2
2010-09-19 16:50:15.962 Connected to database 'mythconverg' at host: 192.168.123.3
2010-09-19 16:50:16.025 mythbackend: MythBackend started as master server
2010-09-19 16:50:16.049 New DB connection, total: 3
2010-09-19 16:50:16.062 Connected to database 'mythconverg' at host: 192.168.123.3
2010-09-19 16:50:16.796 New DB scheduler connection
2010-09-19 16:50:16.806 Connected to database 'mythconverg' at host: 192.168.123.3
2010-09-19 16:50:16.817 Scheduler, Warning: Listings source 'tw-analog' is defined, but is not attached to a card input.
2010-09-19 16:50:16.830 Main::Registering HttpStatus Extension
2010-09-19 16:50:16.839 Enabled verbose msgs:  important general
2010-09-19 16:50:16.850 AutoExpire: ERROR: Filesystem Info cache is empty, unable to calculate necessary parameters.
2010-09-19 16:50:16.864 mythbackend: Autoexpire CalcParams: ERROR: Filesystem Info cache is empty, unable to calculate necessary parameters.
2010-09-19 16:50:19.832 Reschedule requested for id -1.
2010-09-19 16:50:20.089 Scheduled 69 items in 0.3 = 0.03 match + 0.22 place
2010-09-19 16:50:20.096 scheduler: Scheduled items: Scheduled 69 items in 0.3 = 0.03 match + 0.22 place
2010-09-19 16:50:20.107 AUTO-Startup assumed
2010-09-19 16:50:20.119 TVRec(35): ASK_RECORDING 35 0 0 0
2010-09-19 16:50:20.147 TVRec(35): Changing from None to RecordingOnly
2010-09-19 16:50:20.151 TVRec(35): HW Tuner: 35->35
2010-09-19 16:50:20.448 TVRec(36): ASK_RECORDING 36 0 0 0
2010-09-19 16:50:21.376 Program #4 not found in PAT!
Program Association Table
 PSIP tableID(0x0) length(33) extension(0xeb42)
      version(29) current(1) section(0) last_section(0)
         tsid: 60226
 programCount: 6
  program number     0 has PID 0x1ffc   data  0x 0 0x 0 0xff 0xfc
  program number 62351 has PID 0x1fed   data  0xf3 0x8f 0xff 0xed
  program number  1148 has PID 0x 2c0   data  0x 4 0x7c 0xe2 0xc0
  program number  1036 has PID 0x 600   data  0x 4 0x c 0xe6 0x 0
  program number  1041 has PID 0x 350   data  0x 4 0x11 0xe3 0x50
  program number  1065 has PID 0x 850   data  0x 4 0x29 0xe8 0x50

2010-09-19 16:50:21.886 ProcessPAT: Program not found in PAT. 
			Rescan your transports.
2010-09-19 16:50:21.894 Desired program #4 not found in PAT.
			Cannot create single program PAT.
2010-09-19 16:50:24.780 UPnpMedia: BuildMediaMap VIDEO scan starting in :/srv/myvideos:
2010-09-19 16:50:25.018 UPnpMedia: BuildMediaMap Done. Found 857 objects
2010-09-19 16:50:26.831 mythbackend: Running housekeeping thread
2010-09-19 16:51:36.834 AutoExpire: CalcParams(): Max required Free Space: 1.0 GB w/freq: 15 min
2010-09-19 16:51:36.857 Expiring 3625 MB for 4218 at 2010-09-18T12:32:30 => "College Football":"Vanderbilt at Mississippi"
2010-09-19 16:51:36.864 autoexpire: Expiring Program: Expiring 3625 MB for 4218 at 2010-09-18T12:32:30 => "College Football":"Vanderbilt at Mississippi"
2010-09-19 16:51:36.874 Expiring 137 MB for 4218 at 2010-09-18T14:59:00 => "College Football":"Vanderbilt at Mississippi"
2010-09-19 16:51:36.886 autoexpire: Expiring Program: Expiring 137 MB for 4218 at 2010-09-18T14:59:00 => "College Football":"Vanderbilt at Mississippi"
2010-09-19 16:51:36.897 Expiring 467 MB for 4218 at 2010-09-18T15:06:05 => "College Football":"Vanderbilt at Mississippi"
2010-09-19 16:51:36.909 autoexpire: Expiring Program: Expiring 467 MB for 4218 at 2010-09-18T15:06:05 => "College Football":"Vanderbilt at Mississippi"
2010-09-19 16:51:36.919 Expiring 124 MB for 4218 at 2010-09-18T15:25:34 => "College Football":"Vanderbilt at Mississippi"
2010-09-19 16:51:36.931 autoexpire: Expiring Program: Expiring 124 MB for 4218 at 2010-09-18T15:25:34 => "College Football":"Vanderbilt at Mississippi"
2010-09-19 16:51:36.941 Expiring 210 MB for 4218 at 2010-09-18T15:30:00 => Cycling:"Vuelta a Espana, Stage 20"
2010-09-19 16:51:36.953 autoexpire: Expiring Program: Expiring 210 MB for 4218 at 2010-09-18T15:30:00 => Cycling:"Vuelta a Espana, Stage 20"
2010-09-19 16:51:36.963 Expiring 393 MB for 4218 at 2010-09-18T15:42:08 => Cycling:"Vuelta a Espana, Stage 20"
2010-09-19 16:51:36.975 autoexpire: Expiring Program: Expiring 393 MB for 4218 at 2010-09-18T15:42:08 => Cycling:"Vuelta a Espana, Stage 20"