mythfilldatabase broken

[zapstrap]

Not sure where to turn. The SD admin seems to think I'm getting data, but I am most assuredly not. I'm running mythbuntu 14.04, with myth v0.27. I recently renewed my SD subscription and changed my password while I was at it. A couple of weeks later, I noticed myth is not recording anything. A quick look at the listings, and every channel now shows NO DATA. I went into myth's backend setup, and couldn't remember changing the password for schedules direct. I changed that, but it still does not work. Here's a log of what happens when I run mythfilldatabase:

Code: Select all

2016-06-30 09:07:28.153942 C  mythfilldatabase version: fixes/0.27 [v0.27-193-g8ee257c] www.mythtv.org
2016-06-30 09:07:28.153960 C  Qt version: compile: 4.8.6, runtime: 4.8.6
2016-06-30 09:07:28.153966 N  Enabled verbose msgs:  general
2016-06-30 09:07:28.153980 N  Setting Log Level to LOG_INFO
2016-06-30 09:07:28.164839 I  Added logging to the console
2016-06-30 09:07:28.165679 I  Setup Interrupt handler
2016-06-30 09:07:28.165693 I  Setup Terminated handler
2016-06-30 09:07:28.165707 I  Setup Segmentation fault handler
2016-06-30 09:07:28.165719 I  Setup Aborted handler
2016-06-30 09:07:28.165732 I  Setup Bus error handler
2016-06-30 09:07:28.165743 I  Setup Floating point exception handler
2016-06-30 09:07:28.165757 I  Setup Illegal instruction handler
2016-06-30 09:07:28.165769 I  Setup Real-time signal 0 handler
2016-06-30 09:07:28.165814 N  Using runtime prefix = /usr
2016-06-30 09:07:28.165836 N  Using configuration directory = /home/lawrence/.mythtv
2016-06-30 09:07:28.165906 I  Assumed character encoding: en_CA.UTF-8
2016-06-30 09:07:28.166286 N  Empty LocalHostName.
2016-06-30 09:07:28.166298 I  Using localhost value of sigsauer
2016-06-30 09:07:28.186489 N  Setting QT default locale to EN_CA
2016-06-30 09:07:28.186558 I  Current locale EN_CA
2016-06-30 09:07:28.186611 N  Reading locale defaults from /usr/share/mythtv//locales/en_ca.xml
2016-06-30 09:07:28.192856 I  Loading en_us translation for module mythfrontend
2016-06-30 09:07:28.194002 I  Current MythTV Schema Version (DBSchemaVer): 1317
2016-06-30 09:07:28.196061 I  MythCoreContext: Connecting to backend server: x.x.x.x:6543 (try 1 of 1)
2016-06-30 09:07:28.197566 I  Using protocol version 77
2016-06-30 09:07:28.197850 I  Opening blocking connection to master backend
2016-06-30 09:07:28.198548 I  Updating source #1 () with grabber schedulesdirect1
2016-06-30 09:07:28.198690 I  No channels are configured to use grabber.
2016-06-30 09:07:28.198731 I
2016-06-30 09:07:28.198739 I  Checking day @ offset 0, date: Thu Jun 30 2016
2016-06-30 09:07:28.199278 I  Data refresh needed because no data exists for day @ offset 0 from 8PM - midnight.
2016-06-30 09:07:28.199284 N  Refreshing data for Thu Jun 30 2016
2016-06-30 09:07:28.201614 I  Retrieving datadirect data.
2016-06-30 09:07:28.201642 I  Grabbing data for Thu Jun 30 2016 offset 0
2016-06-30 09:07:28.201664 I  From 2016-06-30T00:00:00Z to 2016-07-01T00:00:00Z (UTC)
2016-06-30 09:07:28.201685 I  DataDirect: Grabbing listing data
2016-06-30 09:07:28.201736 I  Downloading DataDirect feed
2016-06-30 09:07:28.271180 I  New Client:  (#1)
2016-06-30 09:07:29.700729 E  DataDirect: Failed to get data: Download error
2016-06-30 09:07:29.700743 E  Encountered error in grabbing data.
2016-06-30 09:07:29.700771 I
2016-06-30 09:07:29.700778 I  Checking day @ offset 1, date: Fri Jul 1 2016
2016-06-30 09:07:29.700783 I  Data Refresh always needed for tomorrow
2016-06-30 09:07:29.700788 N  Refreshing data for Fri Jul 1 2016
2016-06-30 09:07:29.701890 I  Retrieving datadirect data.
2016-06-30 09:07:29.701908 I  Grabbing data for Thu Jun 30 2016 offset 1
2016-06-30 09:07:29.701930 I  From 2016-07-01T00:00:00Z to 2016-07-02T00:00:00Z (UTC)
2016-06-30 09:07:29.701940 I  DataDirect: Grabbing listing data
2016-06-30 09:07:29.701974 I  Downloading DataDirect feed
2016-06-30 09:07:30.102766 E  DataDirect: Failed to get data: Download error
2016-06-30 09:07:30.102775 E  Encountered error in grabbing data.
2016-06-30 09:07:30.102797 I
2016-06-30 09:07:30.102804 I  Checking day @ offset 2, date: Sat Jul 2 2016
2016-06-30 09:07:30.103469 I  Data refresh needed because no data exists for day @ offset 2 from 8PM - midnight.
2016-06-30 09:07:30.103476 N  Refreshing data for Sat Jul 2 2016
2016-06-30 09:07:30.104401 I  Retrieving datadirect data.
2016-06-30 09:07:30.104420 I  Grabbing data for Thu Jun 30 2016 offset 2
2016-06-30 09:07:30.104441 I  From 2016-07-02T00:00:00Z to 2016-07-03T00:00:00Z (UTC)
2016-06-30 09:07:30.104452 I  DataDirect: Grabbing listing data
2016-06-30 09:07:30.104486 I  Downloading DataDirect feed
2016-06-30 09:07:30.505276 E  DataDirect: Failed to get data: Download error
2016-06-30 09:07:30.505285 E  Encountered error in grabbing data.
2016-06-30 09:07:30.505308 I
2016-06-30 09:07:30.505315 I  Checking day @ offset 3, date: Sun Jul 3 2016
2016-06-30 09:07:30.506011 I  Data refresh needed because no data exists for day @ offset 3 from 8PM - midnight.
2016-06-30 09:07:30.506017 N  Refreshing data for Sun Jul 3 2016
2016-06-30 09:07:30.506945 I  Retrieving datadirect data.
2016-06-30 09:07:30.506962 I  Grabbing data for Thu Jun 30 2016 offset 3
2016-06-30 09:07:30.506985 I  From 2016-07-03T00:00:00Z to 2016-07-04T00:00:00Z (UTC)
2016-06-30 09:07:30.506995 I  DataDirect: Grabbing listing data
2016-06-30 09:07:30.507030 I  Downloading DataDirect feed
2016-06-30 09:07:30.907804 E  DataDirect: Failed to get data: Download error
2016-06-30 09:07:30.907813 E  Encountered error in grabbing data.
2016-06-30 09:07:30.907835 I
2016-06-30 09:07:30.907842 I  Checking day @ offset 4, date: Mon Jul 4 2016
2016-06-30 09:07:30.908489 I  Data refresh needed because no data exists for day @ offset 4 from 8PM - midnight.
2016-06-30 09:07:30.908495 N  Refreshing data for Mon Jul 4 2016
2016-06-30 09:07:30.909412 I  Retrieving datadirect data.
2016-06-30 09:07:30.909430 I  Grabbing data for Thu Jun 30 2016 offset 4
2016-06-30 09:07:30.909452 I  From 2016-07-04T00:00:00Z to 2016-07-05T00:00:00Z (UTC)
2016-06-30 09:07:30.909474 I  DataDirect: Grabbing listing data
2016-06-30 09:07:30.909510 I  Downloading DataDirect feed
2016-06-30 09:07:31.310316 E  DataDirect: Failed to get data: Download error
2016-06-30 09:07:31.310325 E  Encountered error in grabbing data.
2016-06-30 09:07:31.310348 I
2016-06-30 09:07:31.310355 I  Checking day @ offset 5, date: Tue Jul 5 2016
2016-06-30 09:07:31.311025 I  Data refresh needed because no data exists for day @ offset 5 from 8PM - midnight.
2016-06-30 09:07:31.311032 N  Refreshing data for Tue Jul 5 2016
2016-06-30 09:07:31.311962 I  Retrieving datadirect data.
2016-06-30 09:07:31.311980 I  Grabbing data for Thu Jun 30 2016 offset 5
2016-06-30 09:07:31.312001 I  From 2016-07-05T00:00:00Z to 2016-07-06T00:00:00Z (UTC)
2016-06-30 09:07:31.312012 I  DataDirect: Grabbing listing data
2016-06-30 09:07:31.312047 I  Downloading DataDirect feed
2016-06-30 09:07:31.712865 E  DataDirect: Failed to get data: Download error
2016-06-30 09:07:31.712874 E  Encountered error in grabbing data.
2016-06-30 09:07:31.712896 I
2016-06-30 09:07:31.712903 I  Checking day @ offset 6, date: Wed Jul 6 2016
2016-06-30 09:07:31.713559 I  Data refresh needed because no data exists for day @ offset 6 from 8PM - midnight.
2016-06-30 09:07:31.713566 N  Refreshing data for Wed Jul 6 2016
2016-06-30 09:07:31.714480 I  Retrieving datadirect data.
2016-06-30 09:07:31.714498 I  Grabbing data for Thu Jun 30 2016 offset 6
2016-06-30 09:07:31.714519 I  From 2016-07-06T00:00:00Z to 2016-07-07T00:00:00Z (UTC)
2016-06-30 09:07:31.714530 I  DataDirect: Grabbing listing data
2016-06-30 09:07:31.714565 I  Downloading DataDirect feed
2016-06-30 09:07:32.115372 E  DataDirect: Failed to get data: Download error
2016-06-30 09:07:32.115381 E  Encountered error in grabbing data.
2016-06-30 09:07:32.115403 I
2016-06-30 09:07:32.115410 I  Checking day @ offset 7, date: Thu Jul 7 2016
2016-06-30 09:07:32.116038 I  Data refresh needed because no data exists for day @ offset 7 from 8PM - midnight.
2016-06-30 09:07:32.116044 N  Refreshing data for Thu Jul 7 2016
2016-06-30 09:07:32.116963 I  Retrieving datadirect data.
2016-06-30 09:07:32.116981 I  Grabbing data for Thu Jun 30 2016 offset 7
2016-06-30 09:07:32.117003 I  From 2016-07-07T00:00:00Z to 2016-07-08T00:00:00Z (UTC)
2016-06-30 09:07:32.117014 I  DataDirect: Grabbing listing data
2016-06-30 09:07:32.117049 I  Downloading DataDirect feed
2016-06-30 09:07:32.517833 E  DataDirect: Failed to get data: Download error
2016-06-30 09:07:32.517842 E  Encountered error in grabbing data.
2016-06-30 09:07:32.517864 I
2016-06-30 09:07:32.517871 I  Checking day @ offset 8, date: Fri Jul 8 2016
2016-06-30 09:07:32.518527 I  Data refresh needed because no data exists for day @ offset 8 from 8PM - midnight.
2016-06-30 09:07:32.518534 N  Refreshing data for Fri Jul 8 2016
2016-06-30 09:07:32.519460 I  Retrieving datadirect data.
2016-06-30 09:07:32.519478 I  Grabbing data for Thu Jun 30 2016 offset 8
2016-06-30 09:07:32.519500 I  From 2016-07-08T00:00:00Z to 2016-07-09T00:00:00Z (UTC)
2016-06-30 09:07:32.519510 I  DataDirect: Grabbing listing data
2016-06-30 09:07:32.519545 I  Downloading DataDirect feed
2016-06-30 09:07:32.920314 E  DataDirect: Failed to get data: Download error
2016-06-30 09:07:32.920323 E  Encountered error in grabbing data.
2016-06-30 09:07:32.920345 I
2016-06-30 09:07:32.920352 I  Checking day @ offset 9, date: Sat Jul 9 2016
2016-06-30 09:07:32.920995 I  Data refresh needed because no data exists for day @ offset 9 from 8PM - midnight.
2016-06-30 09:07:32.921002 N  Refreshing data for Sat Jul 9 2016
2016-06-30 09:07:32.921940 I  Retrieving datadirect data.
2016-06-30 09:07:32.921958 I  Grabbing data for Thu Jun 30 2016 offset 9
2016-06-30 09:07:32.921980 I  From 2016-07-09T00:00:00Z to 2016-07-10T00:00:00Z (UTC)
2016-06-30 09:07:32.921990 I  DataDirect: Grabbing listing data
2016-06-30 09:07:32.922025 I  Downloading DataDirect feed
2016-06-30 09:07:33.322821 E  DataDirect: Failed to get data: Download error
2016-06-30 09:07:33.322831 E  Encountered error in grabbing data.
2016-06-30 09:07:33.322853 I
2016-06-30 09:07:33.322860 I  Checking day @ offset 10, date: Sun Jul 10 2016
2016-06-30 09:07:33.323532 I  Data refresh needed because no data exists for day @ offset 10 from 8PM - midnight.
2016-06-30 09:07:33.323538 N  Refreshing data for Sun Jul 10 2016
2016-06-30 09:07:33.324469 I  Retrieving datadirect data.
2016-06-30 09:07:33.324487 I  Grabbing data for Thu Jun 30 2016 offset 10
2016-06-30 09:07:33.324509 I  From 2016-07-10T00:00:00Z to 2016-07-11T00:00:00Z (UTC)
2016-06-30 09:07:33.324519 I  DataDirect: Grabbing listing data
2016-06-30 09:07:33.324554 I  Downloading DataDirect feed
2016-06-30 09:07:33.725349 E  DataDirect: Failed to get data: Download error
2016-06-30 09:07:33.725357 E  Encountered error in grabbing data.
2016-06-30 09:07:33.725380 I
2016-06-30 09:07:33.725387 I  Checking day @ offset 11, date: Mon Jul 11 2016
2016-06-30 09:07:33.726065 I  Data refresh needed because no data exists for day @ offset 11 from 8PM - midnight.
2016-06-30 09:07:33.726073 N  Refreshing data for Mon Jul 11 2016
2016-06-30 09:07:33.726993 I  Retrieving datadirect data.
2016-06-30 09:07:33.727010 I  Grabbing data for Thu Jun 30 2016 offset 11
2016-06-30 09:07:33.727032 I  From 2016-07-11T00:00:00Z to 2016-07-12T00:00:00Z (UTC)
2016-06-30 09:07:33.727042 I  DataDirect: Grabbing listing data
2016-06-30 09:07:33.727077 I  Downloading DataDirect feed
2016-06-30 09:07:34.127885 E  DataDirect: Failed to get data: Download error
2016-06-30 09:07:34.127894 E  Encountered error in grabbing data.
2016-06-30 09:07:34.127915 I
2016-06-30 09:07:34.127923 I  Checking day @ offset 12, date: Tue Jul 12 2016
2016-06-30 09:07:34.128567 I  Data refresh needed because no data exists for day @ offset 12 from 8PM - midnight.
2016-06-30 09:07:34.128574 N  Refreshing data for Tue Jul 12 2016
2016-06-30 09:07:34.129505 I  Retrieving datadirect data.
2016-06-30 09:07:34.129523 I  Grabbing data for Thu Jun 30 2016 offset 12
2016-06-30 09:07:34.129544 I  From 2016-07-12T00:00:00Z to 2016-07-13T00:00:00Z (UTC)
2016-06-30 09:07:34.129554 I  DataDirect: Grabbing listing data
2016-06-30 09:07:34.129588 I  Downloading DataDirect feed
2016-06-30 09:07:34.530377 E  DataDirect: Failed to get data: Download error
2016-06-30 09:07:34.530387 E  Encountered error in grabbing data.
2016-06-30 09:07:34.530409 I
2016-06-30 09:07:34.530416 I  Checking day @ offset 13, date: Wed Jul 13 2016
2016-06-30 09:07:34.531067 I  Data refresh needed because no data exists for day @ offset 13 from 8PM - midnight.
2016-06-30 09:07:34.531074 N  Refreshing data for Wed Jul 13 2016
2016-06-30 09:07:34.531998 I  Retrieving datadirect data.
2016-06-30 09:07:34.532016 I  Grabbing data for Thu Jun 30 2016 offset 13
2016-06-30 09:07:34.532038 I  From 2016-07-13T00:00:00Z to 2016-07-14T00:00:00Z (UTC)
2016-06-30 09:07:34.532048 I  DataDirect: Grabbing listing data
2016-06-30 09:07:34.532082 I  Downloading DataDirect feed
2016-06-30 09:07:34.932871 E  DataDirect: Failed to get data: Download error
2016-06-30 09:07:34.932880 E  Encountered error in grabbing data.
2016-06-30 09:07:34.946279 I  Updating source #5 (Schedules Direct (Local Broadcast)) with grabber schedulesdirect1
2016-06-30 09:07:34.946472 I  Found 17 channels for source 5 which use grabber
2016-06-30 09:07:34.946501 I
2016-06-30 09:07:34.946509 I  Checking day @ offset 0, date: Thu Jun 30 2016
2016-06-30 09:07:34.947731 I  Data refresh needed because no data exists for day @ offset 0 from 8PM - midnight.
2016-06-30 09:07:34.947738 N  Refreshing data for Thu Jun 30 2016
2016-06-30 09:07:34.948667 I  Retrieving datadirect data.
2016-06-30 09:07:34.948684 I  Grabbing data for Thu Jun 30 2016 offset 0
2016-06-30 09:07:34.948706 I  From 2016-06-30T00:00:00Z to 2016-07-01T00:00:00Z (UTC)
2016-06-30 09:07:34.948717 I  DataDirect: Grabbing listing data
2016-06-30 09:07:34.948752 I  Downloading DataDirect feed
2016-06-30 09:07:35.349609 E  DataDirect: Failed to get data: Download error
2016-06-30 09:07:35.349619 E  Encountered error in grabbing data.
2016-06-30 09:07:35.349642 I
2016-06-30 09:07:35.349650 I  Checking day @ offset 1, date: Fri Jul 1 2016
2016-06-30 09:07:35.349655 I  Data Refresh always needed for tomorrow
2016-06-30 09:07:35.349660 N  Refreshing data for Fri Jul 1 2016
2016-06-30 09:07:35.350678 I  Retrieving datadirect data.
2016-06-30 09:07:35.350696 I  Grabbing data for Thu Jun 30 2016 offset 1
2016-06-30 09:07:35.350717 I  From 2016-07-01T00:00:00Z to 2016-07-02T00:00:00Z (UTC)
2016-06-30 09:07:35.350727 I  DataDirect: Grabbing listing data
2016-06-30 09:07:35.350762 I  Downloading DataDirect feed
2016-06-30 09:07:35.751544 E  DataDirect: Failed to get data: Download error
2016-06-30 09:07:35.751552 E  Encountered error in grabbing data.
2016-06-30 09:07:35.751574 I
2016-06-30 09:07:35.751582 I  Checking day @ offset 2, date: Sat Jul 2 2016
2016-06-30 09:07:35.752897 I  Data refresh needed because no data exists for day @ offset 2 from 8PM - midnight.
2016-06-30 09:07:35.752905 N  Refreshing data for Sat Jul 2 2016
2016-06-30 09:07:35.753867 I  Retrieving datadirect data.
2016-06-30 09:07:35.753886 I  Grabbing data for Thu Jun 30 2016 offset 2
2016-06-30 09:07:35.753908 I  From 2016-07-02T00:00:00Z to 2016-07-03T00:00:00Z (UTC)
2016-06-30 09:07:35.753918 I  DataDirect: Grabbing listing data
2016-06-30 09:07:35.753953 I  Downloading DataDirect feed
2016-06-30 09:07:36.154775 E  DataDirect: Failed to get data: Download error
2016-06-30 09:07:36.154784 E  Encountered error in grabbing data.
2016-06-30 09:07:36.154805 I
2016-06-30 09:07:36.154813 I  Checking day @ offset 3, date: Sun Jul 3 2016
2016-06-30 09:07:36.156118 I  Data refresh needed because no data exists for day @ offset 3 from 8PM - midnight.
2016-06-30 09:07:36.156124 N  Refreshing data for Sun Jul 3 2016
2016-06-30 09:07:36.157060 I  Retrieving datadirect data.
2016-06-30 09:07:36.157078 I  Grabbing data for Thu Jun 30 2016 offset 3
2016-06-30 09:07:36.157101 I  From 2016-07-03T00:00:00Z to 2016-07-04T00:00:00Z (UTC)
2016-06-30 09:07:36.157111 I  DataDirect: Grabbing listing data
2016-06-30 09:07:36.157146 I  Downloading DataDirect feed
2016-06-30 09:07:36.557963 E  DataDirect: Failed to get data: Download error
2016-06-30 09:07:36.557973 E  Encountered error in grabbing data.
2016-06-30 09:07:36.557995 I
2016-06-30 09:07:36.558003 I  Checking day @ offset 4, date: Mon Jul 4 2016
2016-06-30 09:07:36.559328 I  Data refresh needed because no data exists for day @ offset 4 from 8PM - midnight.
2016-06-30 09:07:36.559335 N  Refreshing data for Mon Jul 4 2016
2016-06-30 09:07:36.560279 I  Retrieving datadirect data.
2016-06-30 09:07:36.560297 I  Grabbing data for Thu Jun 30 2016 offset 4
2016-06-30 09:07:36.560319 I  From 2016-07-04T00:00:00Z to 2016-07-05T00:00:00Z (UTC)
2016-06-30 09:07:36.560330 I  DataDirect: Grabbing listing data
2016-06-30 09:07:36.560365 I  Downloading DataDirect feed
2016-06-30 09:07:36.961173 E  DataDirect: Failed to get data: Download error
2016-06-30 09:07:36.961182 E  Encountered error in grabbing data.
2016-06-30 09:07:36.961203 I
2016-06-30 09:07:36.961210 I  Checking day @ offset 5, date: Tue Jul 5 2016
2016-06-30 09:07:36.962533 I  Data refresh needed because no data exists for day @ offset 5 from 8PM - midnight.
2016-06-30 09:07:36.962540 N  Refreshing data for Tue Jul 5 2016
2016-06-30 09:07:36.963472 I  Retrieving datadirect data.
2016-06-30 09:07:36.963490 I  Grabbing data for Thu Jun 30 2016 offset 5
2016-06-30 09:07:36.963512 I  From 2016-07-05T00:00:00Z to 2016-07-06T00:00:00Z (UTC)
2016-06-30 09:07:36.963522 I  DataDirect: Grabbing listing data
2016-06-30 09:07:36.963557 I  Downloading DataDirect feed
2016-06-30 09:07:37.364376 E  DataDirect: Failed to get data: Download error
2016-06-30 09:07:37.364386 E  Encountered error in grabbing data.
2016-06-30 09:07:37.364409 I
2016-06-30 09:07:37.364416 I  Checking day @ offset 6, date: Wed Jul 6 2016
2016-06-30 09:07:37.365751 I  Data refresh needed because no data exists for day @ offset 6 from 8PM - midnight.
2016-06-30 09:07:37.365758 N  Refreshing data for Wed Jul 6 2016
2016-06-30 09:07:37.366699 I  Retrieving datadirect data.
2016-06-30 09:07:37.366717 I  Grabbing data for Thu Jun 30 2016 offset 6
2016-06-30 09:07:37.366738 I  From 2016-07-06T00:00:00Z to 2016-07-07T00:00:00Z (UTC)
2016-06-30 09:07:37.366749 I  DataDirect: Grabbing listing data
2016-06-30 09:07:37.366784 I  Downloading DataDirect feed
2016-06-30 09:07:37.767586 E  DataDirect: Failed to get data: Download error
2016-06-30 09:07:37.767593 E  Encountered error in grabbing data.
2016-06-30 09:07:37.767615 I
2016-06-30 09:07:37.767623 I  Checking day @ offset 7, date: Thu Jul 7 2016
2016-06-30 09:07:37.768912 I  Data refresh needed because no data exists for day @ offset 7 from 8PM - midnight.
2016-06-30 09:07:37.768919 N  Refreshing data for Thu Jul 7 2016
2016-06-30 09:07:37.769875 I  Retrieving datadirect data.
2016-06-30 09:07:37.769894 I  Grabbing data for Thu Jun 30 2016 offset 7
2016-06-30 09:07:37.769916 I  From 2016-07-07T00:00:00Z to 2016-07-08T00:00:00Z (UTC)
2016-06-30 09:07:37.769927 I  DataDirect: Grabbing listing data
2016-06-30 09:07:37.769962 I  Downloading DataDirect feed
2016-06-30 09:07:38.170751 E  DataDirect: Failed to get data: Download error
2016-06-30 09:07:38.170760 E  Encountered error in grabbing data.
2016-06-30 09:07:38.170781 I
2016-06-30 09:07:38.170788 I  Checking day @ offset 8, date: Fri Jul 8 2016
2016-06-30 09:07:38.172089 I  Data refresh needed because no data exists for day @ offset 8 from 8PM - midnight.
2016-06-30 09:07:38.172096 N  Refreshing data for Fri Jul 8 2016
2016-06-30 09:07:38.173031 I  Retrieving datadirect data.
2016-06-30 09:07:38.173048 I  Grabbing data for Thu Jun 30 2016 offset 8
2016-06-30 09:07:38.173070 I  From 2016-07-08T00:00:00Z to 2016-07-09T00:00:00Z (UTC)
2016-06-30 09:07:38.173081 I  DataDirect: Grabbing listing data
2016-06-30 09:07:38.173114 I  Downloading DataDirect feed
2016-06-30 09:07:38.573963 E  DataDirect: Failed to get data: Download error
2016-06-30 09:07:38.573973 E  Encountered error in grabbing data.
2016-06-30 09:07:38.573996 I
2016-06-30 09:07:38.574004 I  Checking day @ offset 9, date: Sat Jul 9 2016
2016-06-30 09:07:38.575333 I  Data refresh needed because no data exists for day @ offset 9 from 8PM - midnight.
2016-06-30 09:07:38.575341 N  Refreshing data for Sat Jul 9 2016
2016-06-30 09:07:38.576291 I  Retrieving datadirect data.
2016-06-30 09:07:38.576309 I  Grabbing data for Thu Jun 30 2016 offset 9
2016-06-30 09:07:38.576330 I  From 2016-07-09T00:00:00Z to 2016-07-10T00:00:00Z (UTC)
2016-06-30 09:07:38.576341 I  DataDirect: Grabbing listing data
2016-06-30 09:07:38.576377 I  Downloading DataDirect feed
2016-06-30 09:07:38.977189 E  DataDirect: Failed to get data: Download error
2016-06-30 09:07:38.977198 E  Encountered error in grabbing data.
2016-06-30 09:07:38.977220 I
2016-06-30 09:07:38.977227 I  Checking day @ offset 10, date: Sun Jul 10 2016
2016-06-30 09:07:38.978559 I  Data refresh needed because no data exists for day @ offset 10 from 8PM - midnight.
2016-06-30 09:07:38.978566 N  Refreshing data for Sun Jul 10 2016
2016-06-30 09:07:38.979494 I  Retrieving datadirect data.
2016-06-30 09:07:38.979512 I  Grabbing data for Thu Jun 30 2016 offset 10
2016-06-30 09:07:38.979533 I  From 2016-07-10T00:00:00Z to 2016-07-11T00:00:00Z (UTC)
2016-06-30 09:07:38.979544 I  DataDirect: Grabbing listing data
2016-06-30 09:07:38.979579 I  Downloading DataDirect feed
2016-06-30 09:07:39.380387 E  DataDirect: Failed to get data: Download error
2016-06-30 09:07:39.380396 E  Encountered error in grabbing data.
2016-06-30 09:07:39.380419 I
2016-06-30 09:07:39.380426 I  Checking day @ offset 11, date: Mon Jul 11 2016
2016-06-30 09:07:39.381759 I  Data refresh needed because no data exists for day @ offset 11 from 8PM - midnight.
2016-06-30 09:07:39.381767 N  Refreshing data for Mon Jul 11 2016
2016-06-30 09:07:39.382714 I  Retrieving datadirect data.
2016-06-30 09:07:39.382733 I  Grabbing data for Thu Jun 30 2016 offset 11
2016-06-30 09:07:39.382754 I  From 2016-07-11T00:00:00Z to 2016-07-12T00:00:00Z (UTC)
2016-06-30 09:07:39.382765 I  DataDirect: Grabbing listing data
2016-06-30 09:07:39.382799 I  Downloading DataDirect feed
2016-06-30 09:07:39.783602 E  DataDirect: Failed to get data: Download error
2016-06-30 09:07:39.783610 E  Encountered error in grabbing data.
2016-06-30 09:07:39.783632 I
2016-06-30 09:07:39.783639 I  Checking day @ offset 12, date: Tue Jul 12 2016
2016-06-30 09:07:39.784935 I  Data refresh needed because no data exists for day @ offset 12 from 8PM - midnight.
2016-06-30 09:07:39.784942 N  Refreshing data for Tue Jul 12 2016
2016-06-30 09:07:39.785899 I  Retrieving datadirect data.
2016-06-30 09:07:39.785917 I  Grabbing data for Thu Jun 30 2016 offset 12
2016-06-30 09:07:39.785938 I  From 2016-07-12T00:00:00Z to 2016-07-13T00:00:00Z (UTC)
2016-06-30 09:07:39.785949 I  DataDirect: Grabbing listing data
2016-06-30 09:07:39.785984 I  Downloading DataDirect feed
2016-06-30 09:07:40.186780 E  DataDirect: Failed to get data: Download error
2016-06-30 09:07:40.186789 E  Encountered error in grabbing data.
2016-06-30 09:07:40.186811 I
2016-06-30 09:07:40.186819 I  Checking day @ offset 13, date: Wed Jul 13 2016
2016-06-30 09:07:40.188109 I  Data refresh needed because no data exists for day @ offset 13 from 8PM - midnight.
2016-06-30 09:07:40.188116 N  Refreshing data for Wed Jul 13 2016
2016-06-30 09:07:40.189057 I  Retrieving datadirect data.
2016-06-30 09:07:40.189074 I  Grabbing data for Thu Jun 30 2016 offset 13
2016-06-30 09:07:40.189096 I  From 2016-07-13T00:00:00Z to 2016-07-14T00:00:00Z (UTC)
2016-06-30 09:07:40.189106 I  DataDirect: Grabbing listing data
2016-06-30 09:07:40.189140 I  Downloading DataDirect feed
2016-06-30 09:07:40.589954 E  DataDirect: Failed to get data: Download error
2016-06-30 09:07:40.589964 E  Encountered error in grabbing data.
2016-06-30 09:07:40.590288 E  Failed to fetch some program info
2016-06-30 09:07:40.590307 I  Adjusting program database end times.
2016-06-30 09:07:40.615951 I      0 replacements made
2016-06-30 09:07:40.615959 I  Marking generic episodes.
2016-06-30 09:07:40.642378 I      Found 0
2016-06-30 09:07:40.642386 I  Extending non-unique programids with multiple parts.
2016-06-30 09:07:40.653412 I      Found 0
2016-06-30 09:07:40.653421 I  Fixing missing original airdates.
2016-06-30 09:07:40.697562 I      Found 0 with programids
2016-06-30 09:07:40.698529 I      Found 0 without programids
2016-06-30 09:07:40.698537 I  Marking repeats.
2016-06-30 09:07:40.701940 I      Found 0
2016-06-30 09:07:40.701948 I  Unmarking new episode rebroadcast repeats.
2016-06-30 09:07:40.711622 I      Found 0
2016-06-30 09:07:40.818894 I  Marking episode first showings.
2016-06-30 09:07:40.885413 I      Found 1453
2016-06-30 09:07:40.885422 I  Marking episode last showings.
2016-06-30 09:07:40.966459 I      Found 1453
2016-06-30 09:07:40.968642 I
===============================================================
| Attempting to contact the master backend for rescheduling.  |
| If the master is not running, rescheduling will happen when |
| the master backend is restarted.                            |
===============================================================
2016-06-30 09:07:40.969248 N  mythfilldatabase run complete.
2016-06-30 09:07:40.969324 I  Waiting for threads to exit.


Can anybody shed a little light on what's gone wrong? I have changed _only_ the password for schedules direct, and they insist I'm getting data.

[rmeden]

Because we are sending data... "200" (success) status followed by size in KB. (method is download)

2016-06-30 16:33:11 75.157..xx.xx MythTV v0.27.20140323-1 200 5917 download 2016-07-13T00:00:00ZZ 2016-07-14T00:00:00ZZ
2016-06-30 16:32:53 75.157..xx.xx MythTV v0.27.20140323-1 200 6134 download 2016-07-12T00:00:00ZZ 2016-07-13T00:00:00ZZ
2016-06-30 16:32:35 75.157..xx.xx MythTV v0.27.20140323-1 200 6133 download 2016-07-11T00:00:00ZZ 2016-07-12T00:00:00ZZ
2016-06-30 16:32:17 75.157..xx.xx MythTV v0.27.20140323-1 200 6009 download 2016-07-10T00:00:00ZZ 2016-07-11T00:00:00ZZ
2016-06-30 16:31:58 75.157..xx.xx MythTV v0.27.20140323-1 200 6220 download 2016-07-09T00:00:00ZZ 2016-07-10T00:00:00ZZ
2016-06-30 16:31:40 75.157..xx.xx MythTV v0.27.20140323-1 200 6144 download 2016-07-08T00:00:00ZZ 2016-07-09T00:00:00ZZ
2016-06-30 16:31:17 75.157..xx.xx MythTV v0.27.20140323-1 200 6138 download 2016-07-07T00:00:00ZZ 2016-07-08T00:00:00ZZ
2016-06-30 16:30:57 75.157..xx.xx MythTV v0.27.20140323-1 200 6137 download 2016-07-06T00:00:00ZZ 2016-07-07T00:00:00ZZ
2016-06-30 16:30:40 75.157..xx.xx MythTV v0.27.20140323-1 200 6199 download 2016-07-05T00:00:00ZZ 2016-07-06T00:00:00ZZ
2016-06-30 16:30:22 75.157..xx.xx MythTV v0.27.20140323-1 200 6202 download 2016-07-04T00:00:00ZZ 2016-07-05T00:00:00ZZ

[zapstrap]

Update...

There are two things going on here:

1. The admin (Robert) believes I'm getting data based on a transaction visible to him, but my end is reporting an error, and more obviously, has no data. With all due respect to Robert (who is very responsive and helpful), I believe a better indicator of download success is required so we don't end up arguing over the wrong thing.

2. The right thing to fight over, is why myth is not able to receive data. Thinking Robert's point is valid, that mythtv might be the culprit, the only change was my password, so I changed it back to its old value and tried running mythfilldatabase again. It worked, even though I did not change the password in mythtv-setup (it still has the new, now invalid, password for SD). So where is this password supposed to be set, since it obviously isn't in the "video sources" menu, where it says data source internal (schedules direct), and has a field for the user name and password? Is this a bug in myth?

Note also that the log snippet supplied by Robert is not from the transaction log I supplied, but from the subsequent transaction with the reverted password, which did work. Could you please show your log data matching the transaction log I supplied? There were several attempts this morning, if that helps. Maybe we can see a difference?

[rmeden]

Sounds to me like your setup is using a method to do the download that doesn't use your GUI password value. All those are system/application problems.. nothing I can help with.

Tracking down the single login failure log entry would be difficult, and I don't see the benefit. The fact that you changed the password back and it started working isolates the problem.

[diyhouse]

pls forgive my limited experience here with SD,... but like your self I have just setup SD to work on my mythTV 0.27 system,... and all went pretty much to plan,... the acc. and passwd all seem to get wrapped up into the output file written by the grabber when the configure option is run,... and provided this is copied to the VideoSource.xmltv file then it should work from the command line..... Well at least it did for me,.. and I was only following the instructions on the how to convert/migrate wiki page.... however the one thing that did get me was the cache folder,... owned by MyUser,... the grabber ran fine of the command line but failed with some strange error message when run by mythTV,... it was only when I ran mfdb as mythTV that I realised the error of my ways... basically the cache folder needed 777 privs so mythtv could also write to it....

To run as mythTV you need to "sudo su - mythtv",... you then become "the mythtv user",... rather than you login user,.. and running mfdb,.. of the command line may then shed some more light on any errors you my be experiencing.

Hope this helps in some way...

Rgds

[ggalt]

I've got a similar issue -- though there has been no change of password. I accidentally allowed my SD account to lapse, but renewed it yesterday. Since then, I've been unable to download data. I'm on Myth 0.27.6 and Fedora 22. Here is the output from mythfilldatabase:

2016-07-11 19:27:07.888830 I Checking day @ offset 13, date: Sun Jul 24 2016
2016-07-11 19:27:07.891280 I Data refresh needed because no data exists for day @ offset 13 from 8PM - midnight.
2016-07-11 19:27:07.891290 N Refreshing data for Sun Jul 24 2016
2016-07-11 19:27:07.891301 I This DataDirect listings source is shared by 2 MythTV lineups
2016-07-11 19:27:07.891306 N We should use cached data for this one
2016-07-11 19:27:07.895679 I Retrieving datadirect data.
2016-07-11 19:27:07.895702 I Grabbing data for Mon Jul 11 2016 offset 13
2016-07-11 19:27:07.895729 I From 2016-07-24T00:00:00Z to 2016-07-25T00:00:00Z (UTC)
2016-07-11 19:27:07.895739 I DataDirect: Grabbing listing data
2016-07-11 19:27:07.895847 I Downloading DataDirect feed
2016-07-11 19:27:10.098359 E DataDirect: Failed to get data: Download error
2016-07-11 19:27:10.098370 E Encountered error in grabbing data.
2016-07-11 19:27:10.115300 E Failed to fetch some program info

Here is info on mythfilldatabase:

$ mythfilldatabase --version
Please attach all output as a file in bug reports.
MythTV Version : v0.27.6-6-g332aa34
MythTV Branch : fixes/0.27
Network Protocol : 77
Library API : 0.27.20151025-1
QT Version : 4.8.7
Options compiled in:
linux release use_hidesyms using_alsa using_jack using_oss using_pulse using_pulseoutput using_backend using_bindings_perl using_bindings_python using_bindings_php using_crystalhd using_dvb using_firewire using_frontend using_hdhomerun using_ceton using_hdpvr using_ivtv using_joystick_menu using_libcec using_libcrypto using_libdns_sd using_libfftw3 using_libxml2 using_libudf using_lirc using_mheg using_opengl using_opengl_video using_qtwebkit using_qtscript using_qtdbus using_taglib using_v4l2 using_x11 using_xrandr using_xv using_bindings_perl using_bindings_python using_bindings_php using_mythtranscode using_opengl using_vaapi using_vdpau using_ffmpeg_threads using_mheg using_libass using_libxml2 using_libudf


Any clues? I've changed nothing in my myth setup or my setup on Schedules Direct (other than paying up for the year).

Thanks,

George