[mythtv-users] SD-Mythfilldatabase problem

Sat Sep 1 23:28:06 UTC 2007

mythfilldatabase runs but reports errors.  It does not update my program
guide.  FC6, 0.20.2-164 from ATRPMS, just upgraded myth yesterday
afternoon.

When I setup my account with SD, I needed to use my email address so it
has a different userid and password than I had been using with Zap2It.
Could this be the problem?

I followed the instructions at
http://www.mythtv.org/docs/mythtv-HOWTO-24.html#ss24.3 but I still have
only 12 days of data event even though Information Center / System
Status / Listing Status on mythfrontend shows a successful
mythfilldatabase just occured.

Mythfilldatabase output shows HTTP errors and a dd_state error.

Any suggestions?  Thanks, Vince

Here is my output from mythfilldatabase:

[root at a22g vince]# mythfilldatabase
Session management error: Authentication Rejected, reason : None of the
authentication protocols specified are supported and host-based
authentication failed
2007-09-01 15:23:05.048 Using runtime prefix = /usr
2007-09-01 15:23:05.247 New DB connection, total: 1
2007-09-01 15:23:05.302 Connected to database 'mythconverg' at host:
localhost
2007-09-01 15:23:05.352 New DB connection, total: 2
2007-09-01 15:23:05.353 Connected to database 'mythconverg' at host:
localhost
2007-09-01 15:23:05.811 Updating source #1 (Antenna) with grabber
schedulesdirect1
2007-09-01 15:23:05.812 Found 10 channels for source 1 which use grabber
2007-09-01 15:23:05.812 
2007-09-01 15:23:05.812 Checking day @ offset 0, date: Sat Sep 1 2007
2007-09-01 15:23:05.869 Data is already present for Sat Sep 1 2007,
skipping
2007-09-01 15:23:05.869 
2007-09-01 15:23:05.869 Checking day @ offset 1, date: Sun Sep 2 2007
2007-09-01 15:23:05.869 Data Refresh always needed for tomorrow
2007-09-01 15:23:05.869 Refreshing data for Sun Sep 2 2007
2007-09-01 15:23:05.870 New DB DataDirect connection
2007-09-01 15:23:05.871 Connected to database 'mythconverg' at host:
localhost
2007-09-01 15:23:05.872 Retrieving datadirect data.
2007-09-01 15:23:05.873 Grabbing data for Sat Sep 1 2007 offset 1
2007-09-01 15:23:05.873 From Sun Sep 2 07:00:00 2007 to Mon Sep 3
07:00:00 2007 (UTC)
2007-09-01 15:23:05.873 Grabbing listing data
--15:23:05--
http://webservices.schedulesdirect.tmsdatadirect.com/schedulesdirect/tvlistings/xtvdService
Resolving webservices.schedulesdirect.tmsdatadirect.com... 206.18.98.175
Connecting to webservices.schedulesdirect.tmsdatadirect.com|
206.18.98.175|:80... connected.
HTTP request sent, awaiting response... 401 Unauthorized
Reusing existing connection to
webservices.schedulesdirect.tmsdatadirect.com:80.
HTTP request sent, awaiting response... 500 Internal Server Error
15:23:06 ERROR 500: Internal Server Error.

2007-09-01 15:23:06.427 Grab complete.  Actual data from  to  (UTC)
2007-09-01 15:23:06.429 Main temp tables populated.
2007-09-01 15:23:06.430 Updating myth channels.
2007-09-01 15:23:06.470 New DB connection, total: 3
2007-09-01 15:23:06.519 Connected to database 'mythconverg' at host:
localhost
2007-09-01 15:23:06.560 Updating icons for sourceid: 1
2007-09-01 15:23:06.712 Channels updated.
2007-09-01 15:23:06.713 DataDirect, Error: UpdateProgramViewTable no
dd_state!
2007-09-01 15:23:06.714 Did not find any new program data.
2007-09-01 15:23:06.714 
2007-09-01 15:23:06.714 Checking day @ offset 2, date: Mon Sep 3 2007
2007-09-01 15:23:06.731 Data is already present for Mon Sep 3 2007,
skipping
<--snip-->
2007-09-01 15:23:06.974 Checking day @ offset 11, date: Wed Sep 12 2007
2007-09-01 15:23:06.997 Data is already present for Wed Sep 12 2007,
skipping
2007-09-01 15:23:06.997 
2007-09-01 15:23:06.997 Checking day @ offset 12, date: Thu Sep 13 2007
2007-09-01 15:23:07.020 Data refresh needed because no data exists for
day @ offset 12 from 6PM - midnight.
2007-09-01 15:23:07.021 Refreshing data for Thu Sep 13 2007
2007-09-01 15:23:07.022 Retrieving datadirect data.
2007-09-01 15:23:07.022 Grabbing data for Sat Sep 1 2007 offset 12
2007-09-01 15:23:07.022 From Thu Sep 13 07:00:00 2007 to Fri Sep 14
07:00:00 2007 (UTC)
2007-09-01 15:23:07.022 Grabbing listing data
--15:23:07--
http://webservices.schedulesdirect.tmsdatadirect.com/schedulesdirect/tvlistings/xtvdService
Resolving webservices.schedulesdirect.tmsdatadirect.com... 206.18.98.175
Connecting to webservices.schedulesdirect.tmsdatadirect.com|
206.18.98.175|:80... connected.
HTTP request sent, awaiting response... 401 Unauthorized
Reusing existing connection to
webservices.schedulesdirect.tmsdatadirect.com:80.
HTTP request sent, awaiting response... 500 Internal Server Error
15:23:07 ERROR 500: Internal Server Error.

2007-09-01 15:23:07.627 Grab complete.  Actual data from  to  (UTC)
2007-09-01 15:23:07.629 Main temp tables populated.
2007-09-01 15:23:07.661 DataDirect, Error: UpdateProgramViewTable no
dd_state!
2007-09-01 15:23:07.662 Did not find any new program data.
2007-09-01 15:23:07.662 
2007-09-01 15:23:07.662 Checking day @ offset 13, date: Fri Sep 14 2007
2007-09-01 15:23:07.692 Data refresh needed because no data exists for
day @ offset 13 from 6PM - midnight.
2007-09-01 15:23:07.692 Refreshing data for Fri Sep 14 2007
2007-09-01 15:23:07.693 Retrieving datadirect data.
2007-09-01 15:23:07.693 Grabbing data for Sat Sep 1 2007 offset 13
2007-09-01 15:23:07.693 From Fri Sep 14 07:00:00 2007 to Sat Sep 15
07:00:00 2007 (UTC)
2007-09-01 15:23:07.694 Grabbing listing data
--15:23:07--
http://webservices.schedulesdirect.tmsdatadirect.com/schedulesdirect/tvlistings/xtvdService
Resolving webservices.schedulesdirect.tmsdatadirect.com... 206.18.98.175
Connecting to webservices.schedulesdirect.tmsdatadirect.com|
206.18.98.175|:80... connected.
HTTP request sent, awaiting response... 401 Unauthorized
Reusing existing connection to
webservices.schedulesdirect.tmsdatadirect.com:80.
HTTP request sent, awaiting response... 500 Internal Server Error
15:23:08 ERROR 500: Internal Server Error.

2007-09-01 15:23:08.276 Grab complete.  Actual data from  to  (UTC)
2007-09-01 15:23:08.294 Main temp tables populated.
2007-09-01 15:23:08.310 DataDirect, Error: UpdateProgramViewTable no
dd_state!
2007-09-01 15:23:08.316 Did not find any new program data.
2007-09-01 15:23:08.653 New DB connection, total: 4
2007-09-01 15:23:08.655 Connected to database 'mythconverg' at host:
localhost
2007-09-01 15:23:08.707 New DB connection, total: 5
2007-09-01 15:23:08.707 Connected to database 'mythconverg' at host:
localhost
2007-09-01 15:23:08.776 Failed to fetch some program info
2007-09-01 15:23:08.776 Adjusting program database end times.
2007-09-01 15:23:08.943     0 replacements made
2007-09-01 15:23:08.943 Marking generic episodes.
2007-09-01 15:23:08.994     Found 0
2007-09-01 15:23:08.994 Marking repeats.
2007-09-01 15:23:09.079     Found 0
2007-09-01 15:23:09.079 Unmarking new episode rebroadcast repeats.
2007-09-01 15:23:09.209     Found 0
2007-09-01 15:23:09.381 Marking episode first showings.
2007-09-01 15:23:11.158     Found 1994
2007-09-01 15:23:11.158 Marking episode last showings.
2007-09-01 15:23:13.228     Found 1994
2007-09-01 15:23:13.371 Grabbing next suggested grabbing time
2007-09-01 15:23:13.818 DataDirect: BlockedTime is: 2007-09-01T15:23:13
2007-09-01 15:23:13.819 DataDirect: NextSuggestedTime is:
2007-09-02T21:58:20
2007-09-01 15:23:13.982 
===============================================================
| Attempting to contact the master backend for rescheduling.  |
| If the master is not running, rescheduling will happen when |
| the master backend is restarted.                            |
===============================================================
2007-09-01 15:23:14.050 Connecting to backend server: 192.168.0.1:6543
(try 1 of 5)
2007-09-01 15:23:14.052 Using protocol version 31
2007-09-01 15:23:14.212 mythfilldatabase run complete.
2007-09-01 15:23:14.215 DataDirect: Deleting temporary files