Mailing List Archive

On 4/19/20 7:00 AM, Jim Abernathy wrote:

I just updated to the latest mythtv update and mythfilldatabase is now
failing:NOTE: reran with --verbose all

mythtv@mythbuntu:~$ mythfilldatabase --verbose all
2020-04-19 07:06:32.884387 C  mythfilldatabase version: fixes/31
[v31.0+fixes.202004181445.8bfc909~ubuntu18.04.1] www.mythtv.org
2020-04-19 07:06:32.884401 C  Qt version: compile: 5.9.5, runtime: 5.9.5
2020-04-19 07:06:32.884419 I  Ubuntu 18.04.4 LTS (x86_64)
2020-04-19 07:06:32.884423 N  Enabled verbose msgs: all
2020-04-19 07:06:32.884430 N  Setting Log Level to LOG_INFO
2020-04-19 07:06:32.894713 I  Added logging to the console
2020-04-19 07:06:32.894908 I  Setup Interrupt handler
2020-04-19 07:06:32.894914 I  Setup Terminated handler
2020-04-19 07:06:32.894917 I  Setup Segmentation fault handler
2020-04-19 07:06:32.894924 I  Setup Aborted handler
2020-04-19 07:06:32.894927 I  Setup Bus error handler
2020-04-19 07:06:32.894932 I  Setup Floating point exception handler
2020-04-19 07:06:32.894940 I  Setup Illegal instruction handler
2020-04-19 07:06:32.894951 I  Setup Real-time signal 0 handler
2020-04-19 07:06:32.894958 I  Setup Hangup handler
2020-04-19 07:06:32.895029 N  Using runtime prefix = /usr
2020-04-19 07:06:32.895031 N  Using configuration directory =
/home/mythtv/.mythtv
2020-04-19 07:06:32.895078 I  Assumed character encoding: en_US.UTF-8
2020-04-19 07:06:32.895267 I  Empty LocalHostName. This is typical.
2020-04-19 07:06:32.895271 I  Using a profile name of: 'mythbuntu'
(Usually the same as this host's name.)
2020-04-19 07:06:32.895275 I  Clearing Settings Cache.
2020-04-19 07:06:32.895294 I  DefaultUPnP() - No default UPnP backend
2020-04-19 07:06:32.895310 I  Start up testing connections. DB
localhost, BE , attempt 0, status dbAwake, Delay: 2000
2020-04-19 07:06:33.896198 I  Clearing Settings Cache.
2020-04-19 07:06:33.901365 I  Database object created: DBManager0
2020-04-19 07:06:33.901379 I  New DB connection, total: 1
2020-04-19 07:06:33.903536 I  [DBManager0] Connected to database
'mythconverg' at host: localhost
2020-04-19 07:06:33.907450 I  Closing DB connection named 'DBManager0'
2020-04-19 07:06:33.907514 I  Clearing Settings Cache.
2020-04-19 07:06:33.907530 I  Clearing Settings Cache.
2020-04-19 07:06:33.907573 I  Database object created: DBManager1
2020-04-19 07:06:33.907581 I  New DB connection, total: 1
2020-04-19 07:06:33.907994 I  [DBManager1] Connected to database
'mythconverg' at host: localhost
2020-04-19 07:06:33.909023 I  MSqlQuery::exec(DBManager1) SELECT data
FROM settings WHERE value = 'language' AND hostname = 'mythbuntu' <<<<
Took 0ms, Returned 1 row(s)
2020-04-19 07:06:33.909569 I  MSqlQuery::exec(DBManager1) SELECT data
FROM settings WHERE value = 'country' AND hostname = 'mythbuntu' <<<<
Took 0ms, Returned 1 row(s)
2020-04-19 07:06:33.909620 N  Setting QT default locale to EN_US
2020-04-19 07:06:33.909630 I  Current locale EN_US
2020-04-19 07:06:33.909678 N  Reading locale defaults from
/usr/share/mythtv//locales/en_us.xml
2020-04-19 07:06:33.910258 I  MSqlQuery::exec(DBManager1) SELECT data
FROM settings WHERE value = 'country' AND hostname = 'mythbuntu' <<<<
Took 0ms, Returned 1 row(s)
2020-04-19 07:06:33.910792 I  MSqlQuery::exec(DBManager1) SELECT data
FROM settings WHERE value = 'freqtable' AND hostname = 'mythbuntu' <<<<
Took 0ms, Returned 0 row(s)
2020-04-19 07:06:33.911245 I  MSqlQuery::exec(DBManager1) SELECT data
FROM settings WHERE value = 'freqtable' AND hostname IS NULL <<<< Took
0ms, Returned 1 row(s)
2020-04-19 07:06:33.911617 I  MSqlQuery::exec(DBManager1) SELECT data
FROM settings WHERE value = 'iso639language0' AND hostname = 'mythbuntu'
<<<< Took 0ms, Returned 0 row(s)
2020-04-19 07:06:33.912003 I  MSqlQuery::exec(DBManager1) SELECT data
FROM settings WHERE value = 'iso639language0' AND hostname IS NULL <<<<
Took 0ms, Returned 1 row(s)
2020-04-19 07:06:33.912442 I  MSqlQuery::exec(DBManager1) SELECT data
FROM settings WHERE value = 'iso639language1' AND hostname = 'mythbuntu'
<<<< Took 0ms, Returned 0 row(s)
2020-04-19 07:06:33.912889 I  MSqlQuery::exec(DBManager1) SELECT data
FROM settings WHERE value = 'iso639language1' AND hostname IS NULL <<<<
Took 0ms, Returned 1 row(s)
2020-04-19 07:06:33.913207 I  MSqlQuery::exec(DBManager1) SELECT data
FROM settings WHERE value = 'language' AND hostname = 'mythbuntu' <<<<
Took 0ms, Returned 1 row(s)
2020-04-19 07:06:33.913749 I  MSqlQuery::exec(DBManager1) SELECT data
FROM settings WHERE value = 'tvformat' AND hostname = 'mythbuntu' <<<<
Took 0ms, Returned 0 row(s)
2020-04-19 07:06:33.914186 I  MSqlQuery::exec(DBManager1) SELECT data
FROM settings WHERE value = 'tvformat' AND hostname IS NULL <<<< Took
0ms, Returned 1 row(s)
2020-04-19 07:06:33.914593 I  MSqlQuery::exec(DBManager1) SELECT data
FROM settings WHERE value = 'vbiformat' AND hostname = 'mythbuntu' <<<<
Took 0ms, Returned 0 row(s)
2020-04-19 07:06:33.914981 I  MSqlQuery::exec(DBManager1) SELECT data
FROM settings WHERE value = 'vbiformat' AND hostname IS NULL <<<< Took
0ms, Returned 1 row(s)
2020-04-19 07:06:33.915363 I  MSqlQuery::exec(DBManager1) SELECT data
FROM settings WHERE value = 'dateformat' AND hostname = 'mythbuntu' <<<<
Took 0ms, Returned 1 row(s)
2020-04-19 07:06:33.915854 I  MSqlQuery::exec(DBManager1) SELECT data
FROM settings WHERE value = 'mytharchivedateformat' AND hostname =
'mythbuntu' <<<< Took 0ms, Returned 1 row(s)
2020-04-19 07:06:33.916334 I  MSqlQuery::exec(DBManager1) SELECT data
FROM settings WHERE value = 'mytharchivetimeformat' AND hostname =
'mythbuntu' <<<< Took 0ms, Returned 1 row(s)
2020-04-19 07:06:33.916796 I  MSqlQuery::exec(DBManager1) SELECT data
FROM settings WHERE value = 'mytharchivevideoformat' AND hostname =
'mythbuntu' <<<< Took 0ms, Returned 1 row(s)
2020-04-19 07:06:33.917183 I  MSqlQuery::exec(DBManager1) SELECT data
FROM settings WHERE value = 'shortdateformat' AND hostname = 'mythbuntu'
<<<< Took 0ms, Returned 1 row(s)
2020-04-19 07:06:33.917520 I  MSqlQuery::exec(DBManager1) SELECT data
FROM settings WHERE value = 'timeformat' AND hostname = 'mythbuntu' <<<<
Took 0ms, Returned 1 row(s)
2020-04-19 07:06:33.917547 I  Enabling Settings Cache.
2020-04-19 07:06:33.917550 I  Clearing Settings Cache.
2020-04-19 07:06:33.932742 I  PowerDBus: Failed to delay sleep,shutdown:
Permission denied
2020-04-19 07:06:33.937209 I  PowerDBus: Added UPower.Device
'/org/freedesktop/UPower/devices/ups_hiddev0'
2020-04-19 07:06:33.937221 I  Power: Unknown power source
2020-04-19 07:06:33.976232 I  Power: Supported actions: None
2020-04-19 07:06:33.976352 E  setHttpProxy() - failed to find a network
proxy
2020-04-19 07:06:33.976881 I  MSqlQuery::exec(DBManager1) SELECT data
FROM settings WHERE value = 'language' AND hostname = 'mythbuntu' <<<<
Took 0ms, Returned 1 row(s)
2020-04-19 07:06:33.977027 I  Loading en_us translation for module
mythfrontend
2020-04-19 07:06:33.977043 I  Disabling Settings Cache.
2020-04-19 07:06:33.977046 I  Clearing Settings Cache.
2020-04-19 07:06:33.977447 I  MSqlQuery::exec(DBManager1) SELECT
GET_LOCK('schemaLock', '1') <<<< Took 0ms, Returned 1 row(s)
2020-04-19 07:06:33.977888 I  MSqlQuery::exec(DBManager1) SELECT data
FROM settings WHERE value = 'dbschemaautoupgrade' AND hostname =
'mythbuntu' <<<< Took 0ms, Returned 0 row(s)
2020-04-19 07:06:33.978243 I  MSqlQuery::exec(DBManager1) SELECT data
FROM settings WHERE value = 'dbschemaautoupgrade' AND hostname IS NULL
<<<< Took 0ms, Returned 0 row(s)
2020-04-19 07:06:33.978629 I  MSqlQuery::exec(DBManager1) SELECT data
FROM settings WHERE value = 'dbschemaver' AND hostname = 'mythbuntu'
<<<< Took 0ms, Returned 0 row(s)
2020-04-19 07:06:33.979104 I  MSqlQuery::exec(DBManager1) SELECT data
FROM settings WHERE value = 'dbschemaver' AND hostname IS NULL <<<< Took
0ms, Returned 1 row(s)
2020-04-19 07:06:33.979149 I  Current MythTV Schema Version
(DBSchemaVer): 1361
2020-04-19 07:06:33.979155 I  Enabling Settings Cache.
2020-04-19 07:06:33.979158 I  Clearing Settings Cache.
2020-04-19 07:06:33.979419 I  MSqlQuery::exec(DBManager1) SELECT
RELEASE_LOCK('schemaLock') <<<< Took 0ms, Returned 1 row(s)
2020-04-19 07:06:33.979971 I  MSqlQuery::exec(DBManager1) SELECT data
FROM settings WHERE value = 'masterservername' AND hostname =
'mythbuntu' <<<< Took 0ms, Returned 0 row(s)
2020-04-19 07:06:33.980424 I  MSqlQuery::exec(DBManager1) SELECT data
FROM settings WHERE value = 'masterservername' AND hostname IS NULL <<<<
Took 0ms, Returned 1 row(s)
2020-04-19 07:06:33.980924 I  MSqlQuery::exec(DBManager1) SELECT data
FROM settings WHERE value = 'backendserveraddr' AND hostname =
'mythbuntu' <<<< Took 0ms, Returned 1 row(s)
2020-04-19 07:06:33.981393 I  MSqlQuery::exec(DBManager1) SELECT data
FROM settings WHERE value = 'backendserverport' AND hostname =
'mythbuntu' <<<< Took 0ms, Returned 1 row(s)
2020-04-19 07:06:33.981844 I  MSqlQuery::exec(DBManager1) SELECT data
FROM settings WHERE value = 'wolbackendcommand' AND hostname =
'mythbuntu' <<<< Took 0ms, Returned 0 row(s)
2020-04-19 07:06:33.982290 I  MSqlQuery::exec(DBManager1) SELECT data
FROM settings WHERE value = 'wolbackendcommand' AND hostname IS NULL
<<<< Took 0ms, Returned 1 row(s)
2020-04-19 07:06:33.982699 I  MSqlQuery::exec(DBManager1) SELECT data
FROM settings WHERE value = 'backendconnectretry' AND hostname =
'mythbuntu' <<<< Took 0ms, Returned 0 row(s)
2020-04-19 07:06:33.983051 I  MSqlQuery::exec(DBManager1) SELECT data
FROM settings WHERE value = 'backendconnectretry' AND hostname IS NULL
<<<< Took 0ms, Returned 0 row(s)
2020-04-19 07:06:33.983086 I MythCoreContext::ConnectCommandSocket():
Connecting to backend server: 192.168.0.250:6543 (try 1 of 1)
2020-04-19 07:06:33.983115 I  MythSocket(555742a93d10:-1):
MythSocket(-1, 0x0) ctor
2020-04-19 07:06:33.983605 I  MythSocket(555742a93d10:-1): IP is local,
using loopback address instead
2020-04-19 07:06:33.983619 I  MythSocket(555742a93d10:-1): attempting
connect() to (127.0.0.1:6543)
2020-04-19 07:06:33.983830 I  MythSocket(555742a93d10:13): Connected to
(127.0.0.1:6543)
2020-04-19 07:06:33.983897 I  MythSocket(555742a93d10:13): write -> 13
29      MYTH_PROTO_VERSION 91 BuzzOff
2020-04-19 07:06:33.985134 I  MythSocket(555742a93d10:13): read <- 13
13      ACCEPT[]:[]91
2020-04-19 07:06:33.985171 I  MythCoreContext::CheckProtoVersion():
Using protocol version 91 BuzzOff
2020-04-19 07:06:33.985253 I  MythSocket(555742a93d10:13): write -> 13
24      ANN Playback mythbuntu 0
2020-04-19 07:06:33.985674 I  MythSocket(555742a93d10:13): read <- 13
2       OK
2020-04-19 07:06:33.985713 I  Opening blocking connection to master backend
2020-04-19 07:06:33.985843 I  MSqlQuery::exec(DBManager1) SELECT
sourceid,name,xmltvgrabber,userid,password,lineupid FROM videosource 
ORDER BY sourceid; <<<< Returns 1 row(s)
2020-04-19 07:06:34.073608 I  MSqlQuery::exec(DBManager1) SELECT
MAX(endtime) FROM program p LEFT JOIN channel c ON p.chanid=c.chanid
WHERE c.deleted IS NULL AND c.sourceid= '1'       AND manualid = 0 AND
c.xmltvid != ''; <<<< Took 87ms, Returned 1 row(s)
2020-04-19 07:06:34.073708 I  Updating source #1 (SD) with grabber
tv_grab_zz_sdjson_sqlite
2020-04-19 07:06:34.074247 I  MSqlQuery::exec(DBManager1) SELECT
COUNT(chanid) FROM channel WHERE deleted IS NULL AND       sourceid =
'1' AND xmltvid != '' <<<< Took 0ms, Returned 1 row(s)
2020-04-19 07:06:34.074263 I  Found 35 channels for source 1 which use
grabber
2020-04-19 07:06:34.074535 I  Starting process manager
2020-04-19 07:06:34.075527 I  Managed child (PID: 3705) has started! *
command=tv_grab_zz_sdjson_sqlite --capabilities, timeout=25
2020-04-19 07:06:34.075703 I  Starting IO manager (read)
2020-04-19 07:06:34.075643 I  (0x555742ad3ff0)::IncrRef() -> 2
2020-04-19 07:06:34.075754 I  Starting process signal handler
2020-04-19 07:06:34.075780 I  Starting IO manager (write)
2020-04-19 07:06:34.577492 I  Managed child (PID: 3705) has exited!
command=tv_grab_zz_sdjson_sqlite --capabilities, status=0, result=0
2020-04-19 07:06:34.626566 I  (0x555742ad3ff0)::DecrRef() -> 1
2020-04-19 07:06:34.626634 I  Grabber has capabilities: baseline
manualconfig preferredmethod lineups apiconfig
2020-04-19 07:06:34.626651 I  (0x555742ad3ff0)::DecrRef() -> 0
2020-04-19 07:06:34.627902 I  Managed child (PID: 3707) has started! *
command=tv_grab_zz_sdjson_sqlite --preferredmethod, timeout=15
2020-04-19 07:06:34.627957 I  (0x7f6628004160)::IncrRef() -> 2
2020-04-19 07:06:35.129792 I  Managed child (PID: 3707) has exited!
command=tv_grab_zz_sdjson_sqlite --preferredmethod, status=0, result=0
2020-04-19 07:06:35.177363 I  (0x7f6628004160)::DecrRef() -> 1
2020-04-19 07:06:35.177404 I  Grabber prefers method: allatonce
2020-04-19 07:06:35.177414 I  (0x7f6628004160)::DecrRef() -> 0
2020-04-19 07:06:35.178154 I  MSqlQuery::exec(DBManager1) SELECT
configpath FROM videosource WHERE sourceid = '1' AND configpath IS NOT
NULL <<<< Took 0ms, Returned 0 row(s)
2020-04-19 07:06:35.178164 I  XMLTV config file is:
/home/mythtv/.mythtv/SD.xmltv
2020-04-19 07:06:35.179259 I  MSqlQuery::exec(DBManager1) DELETE FROM
settings WHERE value = 'MythFillSuggestedRunTime' AND hostname is NULL;
<<<< Took 0ms
2020-04-19 07:06:35.179694 I  MSqlQuery::exec(DBManager1) INSERT INTO
settings (value,data ) VALUES ( 'MythFillSuggestedRunTime',
'2020-04-20T11:06:35Z' ); <<<< Took 0ms
2020-04-19 07:06:35.180121 I  MSqlQuery::exec(DBManager1) DELETE FROM
settings WHERE value = 'mythfilldatabaseLastRunStart' AND hostname is
NULL; <<<< Took 0ms
2020-04-19 07:06:35.180385 I  MSqlQuery::exec(DBManager1) INSERT INTO
settings (value,data ) VALUES ( 'mythfilldatabaseLastRunStart',
'2020-04-19T11:06:35Z' ); <<<< Took 0ms
2020-04-19 07:06:35.180773 I  MSqlQuery::exec(DBManager1) DELETE FROM
settings WHERE value = 'mythfilldatabaseLastRunStatus' AND hostname is
NULL; <<<< Took 0ms
2020-04-19 07:06:35.180998 I  MSqlQuery::exec(DBManager1) INSERT INTO
settings (value,data ) VALUES ( 'mythfilldatabaseLastRunStatus',
'currently running.' ); <<<< Took 0ms
2020-04-19 07:06:35.181014 I  Grabber Command: nice
tv_grab_zz_sdjson_sqlite --config-file '/home/mythtv/.mythtv/SD.xmltv'
--output /tmp/mythIvyIP7
2020-04-19 07:06:35.181017 I  ----------------- Start of XMLTV output
-----------------
2020-04-19 07:06:35.181820 I  Managed child (PID: 3709) has started! *
command=nice tv_grab_zz_sdjson_sqlite --config-file
'/home/mythtv/.mythtv/SD.xmltv' --output /tmp/mythIvyIP7, timeout=0
2020-04-19 07:06:35.181849 I  (0x7f6630005a60)::IncrRef() -> 2
2020-04-19 07:06:36.004958 I  Managed child (PID: 3709) has exited!
command=nice tv_grab_zz_sdjson_sqlite --config-file
'/home/mythtv/.mythtv/SD.xmltv' --output /tmp/mythIvyIP7, status=256,
result=1
2020-04-19 07:06:36.028590 I  (0x7f6630005a60)::DecrRef() -> 1
2020-04-19 07:06:36.028614 I  (0x7f6630005a60)::DecrRef() -> 0
2020-04-19 07:06:36.028653 I  ------------------ End of XMLTV output
------------------
2020-04-19 07:06:36.029574 I  MSqlQuery::exec(DBManager1) DELETE FROM
settings WHERE value = 'mythfilldatabaseLastRunEnd' AND hostname is
NULL; <<<< Took 0ms
2020-04-19 07:06:36.030198 I  MSqlQuery::exec(DBManager1) INSERT INTO
settings (value,data ) VALUES ( 'mythfilldatabaseLastRunEnd',
'2020-04-19T11:06:36Z' ); <<<< Took 0ms
2020-04-19 07:06:36.030252 E  FillData: XMLTV grabber returned error code 1
2020-04-19 07:06:36.030784 I  MSqlQuery::exec(DBManager1) DELETE FROM
settings WHERE value = 'mythfilldatabaseLastRunStatus' AND hostname is
NULL; <<<< Took 0ms
2020-04-19 07:06:36.031183 I  MSqlQuery::exec(DBManager1) INSERT INTO
settings (value,data ) VALUES ( 'mythfilldatabaseLastRunStatus',
'FAILED: XMLTV grabber returned error code 1.' ); <<<< Took 0ms
2020-04-19 07:06:36.031910 I  MSqlQuery::exec(DBManager1) SELECT data
FROM settings WHERE value = 'moviegrabber' AND hostname = 'mythbuntu'
<<<< Took 0ms, Returned 0 row(s)
2020-04-19 07:06:36.032414 I  MSqlQuery::exec(DBManager1) SELECT data
FROM settings WHERE value = 'moviegrabber' AND hostname IS NULL <<<<
Took 0ms, Returned 1 row(s)
2020-04-19 07:06:36.033725 I  Managed child (PID: 3711) has started! *
command=/usr/share/mythtv/metadata/Movie/tmdb3.py -v, timeout=0
2020-04-19 07:06:36.033777 I  (0x555742ad3ff0)::IncrRef() -> 2
2020-04-19 07:06:36.094175 I  Managed child (PID: 3711) has exited!
command=/usr/share/mythtv/metadata/Movie/tmdb3.py -v, status=0, result=0
2020-04-19 07:06:36.128820 I  (0x555742ad3ff0)::DecrRef() -> 1
2020-04-19 07:06:36.129040 I  (0x555742ad3ff0)::DecrRef() -> 0
2020-04-19 07:06:36.130063 I  MSqlQuery::exec(DBManager1) SELECT data
FROM settings WHERE value = 'televisiongrabber' AND hostname =
'mythbuntu' <<<< Took 0ms, Returned 0 row(s)
2020-04-19 07:06:36.130867 I  MSqlQuery::exec(DBManager1) SELECT data
FROM settings WHERE value = 'televisiongrabber' AND hostname IS NULL
<<<< Took 0ms, Returned 1 row(s)
2020-04-19 07:06:36.132119 I  Managed child (PID: 3713) has started! *
command=/usr/share/mythtv/metadata/Television/ttvdb.py -v, timeout=0
2020-04-19 07:06:36.132161 I  (0x7f6630005b50)::IncrRef() -> 2
2020-04-19 07:06:36.373131 I  Managed child (PID: 3713) has exited!
command=/usr/share/mythtv/metadata/Television/ttvdb.py -v, status=0,
result=0
2020-04-19 07:06:36.379229 I  (0x7f6630005b50)::DecrRef() -> 1
2020-04-19 07:06:36.379372 I  (0x7f6630005b50)::DecrRef() -> 0
2020-04-19 07:06:36.379456 E  Error in 1:1: unexpected end of file
2020-04-19 07:06:36.382939 I  MSqlQuery::exec(DBManager1) SELECT
channum, freqid, channel.sourceid, callsign, name, icon, finetune,
videofilters, xmltvid, channel.recpriority, channel.contrast,
channel.brightness, channel.colour, channel.hue, tvformat, visible,
outputfilters, useonairguide, mplexid, serviceid, atsc_major_chan,
atsc_minor_chan, last_record, default_authority, commmethod, tmoffset,
iptvid, channel.chanid, GROUP_CONCAT(DISTINCT
channelgroup.grpid              ORDER BY channelgroup.grpid),
GROUP_CONCAT(DISTINCT capturecard.cardid              ORDER BY
livetvorder), MIN(livetvorder) livetvorder FROM channel LEFT JOIN
channelgroup ON channel.chanid = channelgroup.chanid INNER JOIN
capturecard ON capturecard.sourceid = channel.sourceid WHERE
channel.deleted IS NULL AND channel.sourceid = '1' GROUP BY
channel.chanid ORDER BY LPAD(CAST(channel.channum AS UNSIGNED), 10,
0),          LPAD(channel.channum,  10, 0)  <<<< Took 2ms, Returned 39
row(s)
2020-04-19 07:06:36.384149 I  MSqlQuery::exec(DBManager1) SELECT
DISTINCT cardid FROM capturecard WHERE sourceid = '1' <<<< Took 0ms,
Returned 8 row(s)
2020-04-19 07:06:36.384443 I  MSqlQuery::exec(DBManager1) SELECT
cardtype FROM capturecard WHERE capturecard.cardid = '1' <<<< Took 0ms,
Returned 1 row(s)
2020-04-19 07:06:36.384691 I  MSqlQuery::exec(DBManager1) SELECT
cardtype FROM capturecard WHERE capturecard.cardid = '1' <<<< Took 0ms,
Returned 1 row(s)
2020-04-19 07:06:36.384845 I  MSqlQuery::exec(DBManager1) SELECT
cardtype FROM capturecard WHERE capturecard.cardid = '2' <<<< Took 0ms,
Returned 1 row(s)
2020-04-19 07:06:36.384985 I  MSqlQuery::exec(DBManager1) SELECT
cardtype FROM capturecard WHERE capturecard.cardid = '2' <<<< Took 0ms,
Returned 1 row(s)
2020-04-19 07:06:36.385121 I  MSqlQuery::exec(DBManager1) SELECT
cardtype FROM capturecard WHERE capturecard.cardid = '3' <<<< Took 0ms,
Returned 1 row(s)
2020-04-19 07:06:36.385257 I  MSqlQuery::exec(DBManager1) SELECT
cardtype FROM capturecard WHERE capturecard.cardid = '3' <<<< Took 0ms,
Returned 1 row(s)
2020-04-19 07:06:36.385393 I  MSqlQuery::exec(DBManager1) SELECT
cardtype FROM capturecard WHERE capturecard.cardid = '4' <<<< Took 0ms,
Returned 1 row(s)
2020-04-19 07:06:36.385528 I  MSqlQuery::exec(DBManager1) SELECT
cardtype FROM capturecard WHERE capturecard.cardid = '4' <<<< Took 0ms,
Returned 1 row(s)
2020-04-19 07:06:36.385669 I  MSqlQuery::exec(DBManager1) SELECT
cardtype FROM capturecard WHERE capturecard.cardid = '15' <<<< Took 0ms,
Returned 1 row(s)
2020-04-19 07:06:36.385806 I  MSqlQuery::exec(DBManager1) SELECT
cardtype FROM capturecard WHERE capturecard.cardid = '15' <<<< Took 0ms,
Returned 1 row(s)
2020-04-19 07:06:36.385944 I  MSqlQuery::exec(DBManager1) SELECT
cardtype FROM capturecard WHERE capturecard.cardid = '16' <<<< Took 0ms,
Returned 1 row(s)
2020-04-19 07:06:36.386078 I  MSqlQuery::exec(DBManager1) SELECT
cardtype FROM capturecard WHERE capturecard.cardid = '16' <<<< Took 0ms,
Returned 1 row(s)
2020-04-19 07:06:36.386217 I  MSqlQuery::exec(DBManager1) SELECT
cardtype FROM capturecard WHERE capturecard.cardid = '17' <<<< Took 0ms,
Returned 1 row(s)
2020-04-19 07:06:36.386352 I  MSqlQuery::exec(DBManager1) SELECT
cardtype FROM capturecard WHERE capturecard.cardid = '17' <<<< Took 0ms,
Returned 1 row(s)
2020-04-19 07:06:36.386489 I  MSqlQuery::exec(DBManager1) SELECT
cardtype FROM capturecard WHERE capturecard.cardid = '18' <<<< Took 0ms,
Returned 1 row(s)
2020-04-19 07:06:36.386633 I  MSqlQuery::exec(DBManager1) SELECT
cardtype FROM capturecard WHERE capturecard.cardid = '18' <<<< Took 0ms,
Returned 1 row(s)
2020-04-19 07:06:36.386790 I  MSqlQuery::exec(DBManager1) SELECT
cardtype, inputname FROM capturecard WHERE capturecard.sourceid = '1'
<<<< Took 0ms, Returned 8 row(s)
2020-04-19 07:06:36.386957 I  MSqlQuery::exec(DBManager1) SELECT
cardtype, inputname FROM capturecard WHERE capturecard.sourceid = '1'
<<<< Took 0ms, Returned 8 row(s)
2020-04-19 07:06:36.387036 I  No programs found in data.
2020-04-19 07:06:36.474183 I  MSqlQuery::exec(DBManager1) SELECT
MAX(endtime) FROM program p LEFT JOIN channel c ON p.chanid=c.chanid
WHERE c.deleted IS NULL AND c.sourceid= '1' AND manualid = 0 AND
c.xmltvid != ''; <<<< Took 86ms, Returned 1 row(s)
2020-04-19 07:06:36.474252 E  Failed to fetch some program info
2020-04-19 07:06:36.474268 I  Adjusting program database end times.
2020-04-19 07:06:36.474512 I  MSqlQuery::exec(DBManager1) SELECT chanid,
starttime, endtime FROM program WHERE endtime = '0000-00-00 00:00:00'
ORDER BY chanid, starttime; <<<< Returns 0 row(s)
2020-04-19 07:06:36.474525 I      0 replacements made
2020-04-19 07:06:36.474527 I  Marking generic episodes.
2020-04-19 07:06:36.564696 I  MSqlQuery::exec(DBManager1) UPDATE program
SET generic = 1 WHERE ((programid = '' AND subtitle = '' AND description
= '') OR  (programid <> '' AND category_type = 'series' AND  
program.programid LIKE ' <<<< Took 90ms00'));%4
2020-04-19 07:06:36.564723 I      Found 0
2020-04-19 07:06:36.564725 I  Extending non-unique programids with
multiple parts.
2020-04-19 07:06:36.578355 I  MSqlQuery::exec(DBManager1) SELECT
DISTINCT programid, partnumber, parttotal FROM program WHERE partnumber
> 0 AND parttotal > 0 AND programid LIKE ' <<<< Took 13ms00', Returned
0 row(s)%4
2020-04-19 07:06:36.578563 I      Found 0
2020-04-19 07:06:36.578568 I  Fixing missing original airdates.
2020-04-19 07:06:36.655623 I  MSqlQuery::exec(DBManager1) UPDATE program
p JOIN (   SELECT programid, MAX(originalairdate) maxoad FROM program  
WHERE programid <> '' AND originalairdate IS NOT NULL   GROUP BY
programid ) oad   ON p.programid = oad.programid SET p.originalairdate =
oad.maxoad WHERE p.originalairdate IS NULL <<<< Took 76ms
2020-04-19 07:06:36.655639 I      Found 0 with programids
2020-04-19 07:06:36.656323 I  MSqlQuery::exec(DBManager1) UPDATE program
p JOIN (   SELECT title, subtitle, description, MAX(originalairdate)
maxoad   FROM program   WHERE programid = '' AND         originalairdate
IS NOT NULL   GROUP BY title, subtitle, description ) oad   ON
p.programid = '' AND      p.title = oad.title AND      p.subtitle =
oad.subtitle AND      p.description = oad.description SET
p.originalairdate = oad.maxoad WHERE p.originalairdate IS NULL <<<< Took 0ms
2020-04-19 07:06:36.656340 I      Found 0 without programids
2020-04-19 07:06:36.656343 I  Marking repeats.
2020-04-19 07:06:36.656806 I  MSqlQuery::exec(DBManager1) SELECT data
FROM settings WHERE value = 'newepisodewindow' AND hostname =
'mythbuntu' <<<< Took 0ms, Returned 0 row(s)
2020-04-19 07:06:36.657248 I  MSqlQuery::exec(DBManager1) SELECT data
FROM settings WHERE value = 'newepisodewindow' AND hostname IS NULL <<<<
Took 0ms, Returned 0 row(s)
2020-04-19 07:06:36.669302 I  MSqlQuery::exec(DBManager1) UPDATE program
SET previouslyshown = 1 WHERE previouslyshown = 0 AND originalairdate is
not null AND (to_days(starttime) - to_days(originalairdate))     > '14';
<<<< Took 11ms
2020-04-19 07:06:36.669308 I      Found 0
2020-04-19 07:06:36.669310 I  Unmarking new episode rebroadcast repeats.
2020-04-19 07:06:36.740406 I  MSqlQuery::exec(DBManager1) UPDATE program
SET previouslyshown = 0 WHERE previouslyshown = 1 AND originalairdate is
not null AND (to_days(starttime) - to_days(originalairdate))     <=
'14'; <<<< Took 70ms
2020-04-19 07:06:36.740417 I      Found 0
2020-04-19 07:06:36.965381 I  MSqlQuery::exec(DBManager1) UPDATE program
SET first = 0, last = 0; <<<< Took 224ms
2020-04-19 07:06:36.965388 I  Marking episode first showings.
2020-04-19 07:06:37.403619 I  MSqlQuery::exec(DBManager1) UPDATE program
JOIN (SELECT MIN(p.starttime) AS starttime, p.programid       FROM
program p, channel c       WHERE p.programid <> ''             AND
p.chanid = c.chanid             AND c.deleted IS NULL             AND
c.visible > 0       GROUP BY p.programid      ) AS firsts ON
program.programid = firsts.programid   AND program.starttime =
firsts.starttime SET program.first=1; <<<< Took 438ms
2020-04-19 07:06:37.404189 I  MSqlQuery::exec(DBManager1) UPDATE program
JOIN (SELECT MIN(p.starttime) AS starttime, p.title,
p.subtitle,            LEFT(p.description, 1024) AS partdesc FROM
program p, channel c       WHERE p.programid = '' AND p.chanid =
c.chanid             AND c.deleted IS NULL             AND c.visible >
0       GROUP BY p.title, p.subtitle, partdesc      ) AS firsts ON
program.starttime = firsts.starttime   AND program.title =
firsts.title   AND program.subtitle = firsts.subtitle   AND
LEFT(program.description, 1024) = firsts.partdesc SET program.first = 1
WHERE program.programid = ''; <<<< Took 0ms
2020-04-19 07:06:37.404197 I      Found 19292
2020-04-19 07:06:37.404200 I  Marking episode last showings.
2020-04-19 07:06:37.844684 I  MSqlQuery::exec(DBManager1) UPDATE program
JOIN (SELECT MAX(p.starttime) AS starttime, p.programid       FROM
program p, channel c       WHERE p.programid <> ''             AND
p.chanid = c.chanid             AND c.deleted IS NULL             AND
c.visible > 0       GROUP BY p.programid      ) AS lasts ON
program.programid = lasts.programid AND program.starttime =
lasts.starttime SET program.last=1; <<<< Took 440ms
2020-04-19 07:06:37.845390 I  MSqlQuery::exec(DBManager1) UPDATE program
JOIN (SELECT MAX(p.starttime) AS starttime, p.title,
p.subtitle,            LEFT(p.description, 1024) AS partdesc FROM
program p, channel c       WHERE p.programid = '' AND p.chanid =
c.chanid             AND c.deleted IS NULL             AND c.visible >
0       GROUP BY p.title, p.subtitle, partdesc      ) AS lasts ON
program.starttime = lasts.starttime   AND program.title = lasts.title  
AND program.subtitle = lasts.subtitle   AND LEFT(program.description,
1024) = lasts.partdesc SET program.last = 1 WHERE program.programid =
''; <<<< Took 0ms
2020-04-19 07:06:37.845399 I      Found 19288
2020-04-19 07:06:37.848937 I  MSqlQuery::exec(DBManager1) SELECT
count(previouslyshown) FROM program WHERE previouslyshown = 1; <<<< Took
3ms, Returned 1 row(s)
2020-04-19 07:06:37.849467 I  MSqlQuery::exec(DBManager1) DELETE FROM
settings WHERE value = 'HaveRepeats' AND hostname is NULL; <<<< Took 0ms
2020-04-19 07:06:37.849798 I  MSqlQuery::exec(DBManager1) INSERT INTO
settings (value,data ) VALUES ( 'HaveRepeats', '1' ); <<<< Took 0ms
2020-04-19 07:06:37.849831 I
===============================================================
| Attempting to contact the master backend for rescheduling.  |
| If the master is not running, rescheduling will happen when |
| the master backend is restarted.                            |
===============================================================
2020-04-19 07:06:37.849963 I  MythSocket(555742a93d10:13): write -> 13
56      RESCHEDULE_RECORDINGS[]:[]MATCH 0 0 0 - MythFillDatabase
2020-04-19 07:06:37.850501 I  MythSocket(555742a93d10:13): read <- 13
1       1
2020-04-19 07:06:37.850709 N  mythfilldatabase run complete.

2020-04-19 07:06:37.850758 I  (0x555742acd4a0)::DecrRef() -> 0

2020-04-19 07:06:37.850762 I  PowerDBus: Closing interfaces
2020-04-19 07:06:37.850864 I  MythSocket(555742a93d10:13): write -> 13
32      MESSAGE[]:[]CLEAR_SETTINGS_CACHE
2020-04-19 07:06:37.851051 I  Waiting for threads to exit.
2020-04-19 07:06:37.851134 I  MythSocket(555742a93d10:13): read <- 13
2       OK
2020-04-19 07:06:37.851181 I  MythSocket(555742a93d10:13): write -> 13
62      MESSAGE[]:[]SYSTEM_EVENT MYTHFILLDATABASE_RAN SENDER mythbuntu
2020-04-19 07:06:37.851352 I  MythSocket(555742a93d10:13): read <- 13
2       OK
2020-04-19 07:06:37.851410 I  Exiting


Never seen this error before.

Jim A

>
_______________________________________________
mythtv-users mailing list
mythtv-users@mythtv.org
http://lists.mythtv.org/mailman/listinfo/mythtv-users
http://wiki.mythtv.org/Mailing_List_etiquette
MythTV Forums: https://forum.mythtv.org

On 4/19/20 7:10 AM, Jim Abernathy wrote:
>
> On 4/19/20 7:00 AM, Jim Abernathy wrote:
>
> I just updated to the latest mythtv update and mythfilldatabase is now
> failing:NOTE: reran with --verbose all
>
> mythtv@mythbuntu:~$ mythfilldatabase --verbose all
> 2020-04-19 07:06:32.884387 C  mythfilldatabase version: fixes/31
> [v31.0+fixes.202004181445.8bfc909~ubuntu18.04.1] www.mythtv.org

Just saw this posted on SchedulesDirect website.


Notice:

**** KNOWN SERVER ISSUES. TRY AGAIN LATER IF AFFECTED. ****
SD_JSON:Server offline for maintenance.


_______________________________________________
mythtv-users mailing list
mythtv-users@mythtv.org
http://lists.mythtv.org/mailman/listinfo/mythtv-users
http://wiki.mythtv.org/Mailing_List_etiquette
MythTV Forums: https://forum.mythtv.org

On Sun, 19 Apr 2020 07:00:05 -0400, you wrote:

>2020-04-19 06:57:42.029056 E? Error in 1:1: unexpected end of file

This usually means the download of the EPG data failed - either the
downloaded file size is 0, or less likely the download stopped in the
middle.
_______________________________________________
mythtv-users mailing list
mythtv-users@mythtv.org
http://lists.mythtv.org/mailman/listinfo/mythtv-users
http://wiki.mythtv.org/Mailing_List_etiquette
MythTV Forums: https://forum.mythtv.org

On 4/19/20 8:11 AM, Stephen Worthington wrote:
> On Sun, 19 Apr 2020 07:00:05 -0400, you wrote:
>
>> 2020-04-19 06:57:42.029056 E  Error in 1:1: unexpected end of file
> This usually means the download of the EPG data failed - either the
> downloaded file size is 0, or less likely the download stopped in the
> middle.

That was it, I found a JSON server down message on their website.

Jim A

_______________________________________________
mythtv-users mailing list
mythtv-users@mythtv.org
http://lists.mythtv.org/mailman/listinfo/mythtv-users
http://wiki.mythtv.org/Mailing_List_etiquette
MythTV Forums: https://forum.mythtv.org

On 4/19/20, Jim Abernathy <jfabernathy@gmail.com> wrote:
>
>
> That was it, I found a JSON server down message on their website.
>
> Jim A
>

I just looked after reading your post and mine (using
tv_grab_zz_sdjson) failed this morning as well:

Last mythfilldatabase run started on Sun Apr 19 2020, 9:00 AM and
ended on Sun Apr 19 2020, 9:01 AM. FAILED: XMLTV grabber returned
error code 255.

Thanks for noticing that message on their site!

Tom
_______________________________________________
mythtv-users mailing list
mythtv-users@mythtv.org
http://lists.mythtv.org/mailman/listinfo/mythtv-users
http://wiki.mythtv.org/Mailing_List_etiquette
MythTV Forums: https://forum.mythtv.org

Here is the SD forum post announcing the maintenance (which is going
*way* over)

https://forums.schedulesdirect.org/viewtopic.php?f=18&t=3065

Robert

_______________________________________________
mythtv-users mailing list
mythtv-users@mythtv.org
http://lists.mythtv.org/mailman/listinfo/mythtv-users
http://wiki.mythtv.org/Mailing_List_etiquette
MythTV Forums: https://forum.mythtv.org

On Sun, Apr 19, 2020 at 12:20 PM Robert Eden <rmeden@gmail.com> wrote:
> https://forums.schedulesdirect.org/viewtopic.php?f=18&t=3065

Yes, it's going longer than expected; I will perform maintenance more
often, to make the outages shorter.

There is a system messages element on the JSON service which indicated
that servers were going to be down for maintenance. I don't know if
those are then put into the XML.
_______________________________________________
mythtv-users mailing list
mythtv-users@mythtv.org
http://lists.mythtv.org/mailman/listinfo/mythtv-users
http://wiki.mythtv.org/Mailing_List_etiquette
MythTV Forums: https://forum.mythtv.org

On 4/19/20 2:05 PM, Robert Kulagowski wrote:
> On Sun, Apr 19, 2020 at 12:20 PM Robert Eden <rmeden@gmail.com> wrote:
>> https://forums.schedulesdirect.org/viewtopic.php?f=18&t=3065
> Yes, it's going longer than expected; I will perform maintenance more
> often, to make the outages shorter.
>
> There is a system messages element on the JSON service which indicated
> that servers were going to be down for maintenance. I don't know if
> those are then put into the XML.

My overnight runs failed and I ran mythfilldatabase this morning USA EDT
and it seemed to be running because it took 6 minutes, but it returned
an error 1. The SD site says service is restored, but ...

mythtv@mythbuntu:~$ mythfilldatabase
2020-04-20 07:09:39.782376 C  mythfilldatabase version: fixes/31
[v31.0+fixes.202004181445.8bfc909~ubuntu18.04.1] www.mythtv.org
2020-04-20 07:09:39.782398 C  Qt version: compile: 5.9.5, runtime: 5.9.5
2020-04-20 07:09:39.782428 I  Ubuntu 18.04.4 LTS (x86_64)
2020-04-20 07:09:39.782434 N  Enabled verbose msgs:  general
2020-04-20 07:09:39.782446 N  Setting Log Level to LOG_INFO
2020-04-20 07:09:39.792784 I  Added logging to the console
2020-04-20 07:09:39.793370 I  Setup Interrupt handler
2020-04-20 07:09:39.793397 I  Setup Terminated handler
2020-04-20 07:09:39.793410 I  Setup Segmentation fault handler
2020-04-20 07:09:39.793419 I  Setup Aborted handler
2020-04-20 07:09:39.793436 I  Setup Bus error handler
2020-04-20 07:09:39.793446 I  Setup Floating point exception handler
2020-04-20 07:09:39.793459 I  Setup Illegal instruction handler
2020-04-20 07:09:39.793470 I  Setup Real-time signal 0 handler
2020-04-20 07:09:39.793483 I  Setup Hangup handler
2020-04-20 07:09:39.793596 N  Using runtime prefix = /usr
2020-04-20 07:09:39.793602 N  Using configuration directory =
/home/mythtv/.mythtv
2020-04-20 07:09:39.793682 I  Assumed character encoding: en_US.UTF-8
2020-04-20 07:09:39.794001 I  Empty LocalHostName. This is typical.
2020-04-20 07:09:39.794009 I  Using a profile name of: 'mythbuntu'
(Usually the same as this host's name.)
2020-04-20 07:09:39.794070 I  Start up testing connections. DB
localhost, BE , attempt 0, status dbAwake, Delay: 2000
2020-04-20 07:09:40.811653 N  Setting QT default locale to EN_US
2020-04-20 07:09:40.811666 I  Current locale EN_US
2020-04-20 07:09:40.811719 N  Reading locale defaults from
/usr/share/mythtv//locales/en_us.xml
2020-04-20 07:09:40.834597 I  PowerDBus: Failed to delay sleep,shutdown:
Permission denied
2020-04-20 07:09:40.838819 I  PowerDBus: Added UPower.Device
'/org/freedesktop/UPower/devices/ups_hiddev0'
2020-04-20 07:09:40.838827 I  Power: Unknown power source
2020-04-20 07:09:40.874796 I  Power: Supported actions: None
2020-04-20 07:09:40.875378 I  Loading en_us translation for module
mythfrontend
2020-04-20 07:09:40.877390 I  Current MythTV Schema Version
(DBSchemaVer): 1361
2020-04-20 07:09:40.879819 I MythCoreContext::ConnectCommandSocket():
Connecting to backend server: 192.168.0.250:6543 (try 1 of 1)
2020-04-20 07:09:40.881226 I MythCoreContext::CheckProtoVersion(): Using
protocol version 91 BuzzOff
2020-04-20 07:09:40.881712 I  Opening blocking connection to master backend
2020-04-20 07:09:40.972715 I  Updating source #1 (SD) with grabber
tv_grab_zz_sdjson_sqlite
2020-04-20 07:09:40.973330 I  Found 35 channels for source 1 which use
grabber
2020-04-20 07:09:40.973568 I  Starting process manager
2020-04-20 07:09:40.973587 I  Starting process signal handler
2020-04-20 07:09:40.974589 I  Starting IO manager (read)
2020-04-20 07:09:40.974608 I  Starting IO manager (write)
2020-04-20 07:09:42.626228 I  Grabber has capabilities: baseline
manualconfig preferredmethod lineups apiconfig
2020-04-20 07:09:43.176946 I  Grabber prefers method: allatonce
2020-04-20 07:09:43.177826 I  XMLTV config file is:
/home/mythtv/.mythtv/SD.xmltv
2020-04-20 07:15:52.833432 E  FillData: XMLTV grabber returned error code 1
2020-04-20 07:15:54.434621 E  Error in 1:1: unexpected end of file
2020-04-20 07:15:54.445734 I  No programs found in data.
2020-04-20 07:15:54.531105 E  Failed to fetch some program info
2020-04-20 07:15:54.531126 I  Adjusting program database end times.
2020-04-20 07:15:54.531449 I      0 replacements made
2020-04-20 07:15:54.531453 I  Marking generic episodes.
2020-04-20 07:15:54.622069 I      Found 0
2020-04-20 07:15:54.622074 I  Extending non-unique programids with
multiple parts.
2020-04-20 07:15:54.635902 I      Found 0
2020-04-20 07:15:54.635907 I  Fixing missing original airdates.
2020-04-20 07:15:54.713059 I      Found 0 with programids
2020-04-20 07:15:54.713600 I      Found 0 without programids
2020-04-20 07:15:54.713604 I  Marking repeats.
2020-04-20 07:15:54.727282 I      Found 0
2020-04-20 07:15:54.727287 I  Unmarking new episode rebroadcast repeats.
2020-04-20 07:15:54.798499 I      Found 0
2020-04-20 07:15:55.025975 I  Marking episode first showings.
2020-04-20 07:15:55.474967 I      Found 19292
2020-04-20 07:15:55.474974 I  Marking episode last showings.
2020-04-20 07:15:55.924484 I      Found 19288
2020-04-20 07:15:55.928680 I
===============================================================
| Attempting to contact the master backend for rescheduling.  |
| If the master is not running, rescheduling will happen when |
| the master backend is restarted.                            |
===============================================================
2020-04-20 07:15:55.929592 N  mythfilldatabase run complete.
2020-04-20 07:15:55.929663 I  PowerDBus: Closing interfaces
2020-04-20 07:15:55.930030 I  Waiting for threads to exit.
2020-04-20 07:15:55.930229 I  Exiting


_______________________________________________
mythtv-users mailing list
mythtv-users@mythtv.org
http://lists.mythtv.org/mailman/listinfo/mythtv-users
http://wiki.mythtv.org/Mailing_List_etiquette
MythTV Forums: https://forum.mythtv.org

On 4/20/20, Jim Abernathy <jfabernathy@gmail.com> wrote:
>
> On 4/19/20 2:05 PM, Robert Kulagowski wrote:
>> On Sun, Apr 19, 2020 at 12:20 PM Robert Eden <rmeden@gmail.com> wrote:
>>> https://forums.schedulesdirect.org/viewtopic.php?f=18&t=3065
>> Yes, it's going longer than expected; I will perform maintenance more
>> often, to make the outages shorter.
>>
>> There is a system messages element on the JSON service which indicated
>> that servers were going to be down for maintenance. I don't know if
>> those are then put into the XML.
>
> My overnight runs failed and I ran mythfilldatabase this morning USA EDT
> and it seemed to be running because it took 6 minutes, but it returned
> an error 1. The SD site says service is restored, but ...
>
> mythtv@mythbuntu:~$ mythfilldatabase

My scheduled one failed at 9:00 AM EDT today. I just tried to run it
manually and the grabber took about 3-1/2 minutes to get a 255 status:

2020-04-20 09:44:04.855121 I Grabber has capabilities: baseline
manualconfig preferredmethod
2020-04-20 09:44:05.895130 I Grabber prefers method: allatonce
2020-04-20 09:44:05.896449 I XMLTV config file is:
/home/mythtv/.mythtv/Antenna.xmltv
2020-04-20 09:47:25.345722 E FillData: XMLTV grabber returned error code 255
2020-04-20 09:47:25.603513 E Error in 1:1: unexpected end of file
2020-04-20 09:47:25.645228 I No programs found in data.

I don't see any more notice on the schedulesdirect.org main page any
more, but does it expressly say somewhere that it's restored? I'm not
seeing that.

Tom
_______________________________________________
mythtv-users mailing list
mythtv-users@mythtv.org
http://lists.mythtv.org/mailman/listinfo/mythtv-users
http://wiki.mythtv.org/Mailing_List_etiquette
MythTV Forums: https://forum.mythtv.org

On 4/20/20 9:54 AM, Tom Dexter wrote:
> On 4/20/20, Jim Abernathy <jfabernathy@gmail.com> wrote:
>> On 4/19/20 2:05 PM, Robert Kulagowski wrote:
>>> On Sun, Apr 19, 2020 at 12:20 PM Robert Eden <rmeden@gmail.com> wrote:
>>>> https://forums.schedulesdirect.org/viewtopic.php?f=18&t=3065
>>> Yes, it's going longer than expected; I will perform maintenance more
>>> often, to make the outages shorter.
>>>
>>> There is a system messages element on the JSON service which indicated
>>> that servers were going to be down for maintenance. I don't know if
>>> those are then put into the XML.
>> My overnight runs failed and I ran mythfilldatabase this morning USA EDT
>> and it seemed to be running because it took 6 minutes, but it returned
>> an error 1. The SD site says service is restored, but ...
>>
>> mythtv@mythbuntu:~$ mythfilldatabase
> My scheduled one failed at 9:00 AM EDT today. I just tried to run it
> manually and the grabber took about 3-1/2 minutes to get a 255 status:
>
> 2020-04-20 09:44:04.855121 I Grabber has capabilities: baseline
> manualconfig preferredmethod
> 2020-04-20 09:44:05.895130 I Grabber prefers method: allatonce
> 2020-04-20 09:44:05.896449 I XMLTV config file is:
> /home/mythtv/.mythtv/Antenna.xmltv
> 2020-04-20 09:47:25.345722 E FillData: XMLTV grabber returned error code 255
> 2020-04-20 09:47:25.603513 E Error in 1:1: unexpected end of file
> 2020-04-20 09:47:25.645228 I No programs found in data.
>
> I don't see any more notice on the schedulesdirect.org main page any
> more, but does it expressly say somewhere that it's restored? I'm not
> seeing that.
>
> Tom

What I see is on their forum:

https://forums.schedulesdirect.org/viewtopic.php?f=18&t=3065

note the last line:

2020-04-20 @ 04:25. Service restored.

Jim A

On 4/20/20, Jim Abernathy <jfabernathy@gmail.com> wrote:
>
> On 4/20/20 9:54 AM, Tom Dexter wrote:
>> On 4/20/20, Jim Abernathy <jfabernathy@gmail.com> wrote:
>>> On 4/19/20 2:05 PM, Robert Kulagowski wrote:
>>>> On Sun, Apr 19, 2020 at 12:20 PM Robert Eden <rmeden@gmail.com> wrote:
>>>>> https://forums.schedulesdirect.org/viewtopic.php?f=18&t=3065
>>>> Yes, it's going longer than expected; I will perform maintenance more
>>>> often, to make the outages shorter.
>>>>
>>>> There is a system messages element on the JSON service which indicated
>>>> that servers were going to be down for maintenance. I don't know if
>>>> those are then put into the XML.
>>> My overnight runs failed and I ran mythfilldatabase this morning USA EDT
>>> and it seemed to be running because it took 6 minutes, but it returned
>>> an error 1. The SD site says service is restored, but ...
>>>
>>> mythtv@mythbuntu:~$ mythfilldatabase
>> My scheduled one failed at 9:00 AM EDT today. I just tried to run it
>> manually and the grabber took about 3-1/2 minutes to get a 255 status:
>>
>> 2020-04-20 09:44:04.855121 I Grabber has capabilities: baseline
>> manualconfig preferredmethod
>> 2020-04-20 09:44:05.895130 I Grabber prefers method: allatonce
>> 2020-04-20 09:44:05.896449 I XMLTV config file is:
>> /home/mythtv/.mythtv/Antenna.xmltv
>> 2020-04-20 09:47:25.345722 E FillData: XMLTV grabber returned error code
>> 255
>> 2020-04-20 09:47:25.603513 E Error in 1:1: unexpected end of file
>> 2020-04-20 09:47:25.645228 I No programs found in data.
>>
>> I don't see any more notice on the schedulesdirect.org main page any
>> more, but does it expressly say somewhere that it's restored? I'm not
>> seeing that.
>>
>> Tom
>
> What I see is on their forum:
>
> https://forums.schedulesdirect.org/viewtopic.php?f=18&t=3065
>
> note the last line:
>
> 2020-04-20 @ 04:25. Service restored.
>
> Jim A

Yes...just found that myself. I posted to the forum to see if anyone
else was having issues. Interestingly though I just noticed that the
schedulesdirect.org main page has a big yellow notice (that I don't
think was there this morning?) about known service issues with the the
SD_JSON server.

Tom
_______________________________________________
mythtv-users mailing list
mythtv-users@mythtv.org
http://lists.mythtv.org/mailman/listinfo/mythtv-users
http://wiki.mythtv.org/Mailing_List_etiquette
MythTV Forums: https://forum.mythtv.org

On 20/04/2020 15:32, Tom Dexter wrote:
> On 4/20/20, Jim Abernathy <jfabernathy@gmail.com> wrote:
>> On 4/20/20 9:54 AM, Tom Dexter wrote:
>>> On 4/20/20, Jim Abernathy <jfabernathy@gmail.com> wrote:
>>>> On 4/19/20 2:05 PM, Robert Kulagowski wrote:
>>>>> On Sun, Apr 19, 2020 at 12:20 PM Robert Eden <rmeden@gmail.com> wrote:
>>>>>> https://forums.schedulesdirect.org/viewtopic.php?f=18&t=3065
>>>>> Yes, it's going longer than expected; I will perform maintenance more
>>>>> often, to make the outages shorter.
>>>>>
>>>>> There is a system messages element on the JSON service which indicated
>>>>> that servers were going to be down for maintenance. I don't know if
>>>>> those are then put into the XML.
>>>> My overnight runs failed and I ran mythfilldatabase this morning USA EDT
>>>> and it seemed to be running because it took 6 minutes, but it returned
>>>> an error 1. The SD site says service is restored, but ...
>>>>
>>>> mythtv@mythbuntu:~$ mythfilldatabase
>>> My scheduled one failed at 9:00 AM EDT today. I just tried to run it
>>> manually and the grabber took about 3-1/2 minutes to get a 255 status:
>>>
>>> 2020-04-20 09:44:04.855121 I Grabber has capabilities: baseline
>>> manualconfig preferredmethod
>>> 2020-04-20 09:44:05.895130 I Grabber prefers method: allatonce
>>> 2020-04-20 09:44:05.896449 I XMLTV config file is:
>>> /home/mythtv/.mythtv/Antenna.xmltv
>>> 2020-04-20 09:47:25.345722 E FillData: XMLTV grabber returned error code
>>> 255
>>> 2020-04-20 09:47:25.603513 E Error in 1:1: unexpected end of file
>>> 2020-04-20 09:47:25.645228 I No programs found in data.
>>>
>>> I don't see any more notice on the schedulesdirect.org main page any
>>> more, but does it expressly say somewhere that it's restored? I'm not
>>> seeing that.
>>>
>>> Tom
>> What I see is on their forum:
>>
>> https://forums.schedulesdirect.org/viewtopic.php?f=18&t=3065
>>
>> note the last line:
>>
>> 2020-04-20 @ 04:25. Service restored.
>>
>> Jim A
> Yes...just found that myself. I posted to the forum to see if anyone
> else was having issues. Interestingly though I just noticed that the
> schedulesdirect.org main page has a big yellow notice (that I don't
> think was there this morning?) about known service issues with the the
> SD_JSON server.
>
> Tom

Tried running tv_grab_zz_sdjson manually, it failed, as did a manual run
of mythfilldatabase (error code 255)

mythtv@myth-server-1:~/.xmltv$ less Freeview.xmltv
mythtv@myth-server-1:~/.xmltv$ tv_grab_zz_sdjson --config-file
Freeview.xmltv --output freeview.xml --days 1
Initializing...
** POST https://json.schedulesdirect.org/20141201/token ==> 200 OK (1s)
** GET https://json.schedulesdirect.org/20141201/status ==> 200 OK
Invalid status response.


There are two reports about failure after restore completed time on SD
forum https://forums.schedulesdirect.org/viewtopic.php?f=18&t=3057


Mike




_______________________________________________
mythtv-users mailing list
mythtv-users@mythtv.org
http://lists.mythtv.org/mailman/listinfo/mythtv-users
http://wiki.mythtv.org/Mailing_List_etiquette
MythTV Forums: https://forum.mythtv.org

On 4/20/20 10:48 AM, Mike Bibbings wrote:
> On 20/04/2020 15:32, Tom Dexter wrote:
>> On 4/20/20, Jim Abernathy <jfabernathy@gmail.com> wrote:
>>> On 4/20/20 9:54 AM, Tom Dexter wrote:
>>>> On 4/20/20, Jim Abernathy <jfabernathy@gmail.com> wrote:
>>>>> On 4/19/20 2:05 PM, Robert Kulagowski wrote:
>>>>>> On Sun, Apr 19, 2020 at 12:20 PM Robert Eden <rmeden@gmail.com>
>>>>>> wrote:
>>>>>>> https://forums.schedulesdirect.org/viewtopic.php?f=18&t=3065
>>>>>> Yes, it's going longer than expected; I will perform maintenance
>>>>>> more
>>>>>> often, to make the outages shorter.
>>>>>>
>>>>>> There is a system messages element on the JSON service which
>>>>>> indicated
>>>>>> that servers were going to be down for maintenance. I don't know if
>>>>>> those are then put into the XML.
>>>>> My overnight runs failed and I ran mythfilldatabase this morning
>>>>> USA EDT
>>>>> and it seemed to be running because it took 6 minutes, but it
>>>>> returned
>>>>> an error 1. The SD site says service is restored, but ...
>>>>>
>>>>> mythtv@mythbuntu:~$ mythfilldatabase
>>>> My scheduled one failed at 9:00 AM EDT today. I just tried to run it
>>>> manually and the grabber took about 3-1/2 minutes to get a 255 status:
>>>>
>>>> 2020-04-20 09:44:04.855121 I  Grabber has capabilities: baseline
>>>> manualconfig preferredmethod
>>>> 2020-04-20 09:44:05.895130 I  Grabber prefers method: allatonce
>>>> 2020-04-20 09:44:05.896449 I  XMLTV config file is:
>>>> /home/mythtv/.mythtv/Antenna.xmltv
>>>> 2020-04-20 09:47:25.345722 E  FillData: XMLTV grabber returned
>>>> error code
>>>> 255
>>>> 2020-04-20 09:47:25.603513 E  Error in 1:1: unexpected end of file
>>>> 2020-04-20 09:47:25.645228 I  No programs found in data.
>>>>
>>>> I don't see any more notice on the schedulesdirect.org main page any
>>>> more, but does it expressly say somewhere that it's restored? I'm not
>>>> seeing that.
>>>>
>>>> Tom
>>> What I see is on their forum:
>>>
>>> https://forums.schedulesdirect.org/viewtopic.php?f=18&t=3065
>>>
>>> note the last line:
>>>
>>> 2020-04-20 @ 04:25. Service restored.
>>>
>>> Jim A
>> Yes...just found that myself. I posted to the forum to see if anyone
>> else was having issues. Interestingly though I just noticed that the
>> schedulesdirect.org main page has a big yellow notice (that I don't
>> think was there this morning?) about known service issues with the the
>> SD_JSON server.
>>
>> Tom
>
> Tried running tv_grab_zz_sdjson manually, it failed, as did a manual
> run of mythfilldatabase (error code 255)
>
> mythtv@myth-server-1:~/.xmltv$ less Freeview.xmltv
> mythtv@myth-server-1:~/.xmltv$ tv_grab_zz_sdjson --config-file
> Freeview.xmltv --output freeview.xml --days 1
> Initializing...
> ** POST https://json.schedulesdirect.org/20141201/token ==> 200 OK (1s)
> ** GET https://json.schedulesdirect.org/20141201/status ==> 200 OK
> Invalid status response.
>
>
> There are two reports about failure after restore completed time on SD
> forum https://forums.schedulesdirect.org/viewtopic.php?f=18&t=3057
>
>
> Mike
>
At this point I think we all can assume it's the server issue, but to
confirm a different way I did a fresh install of Raspbian buster on a
RPi4 and went thru my normal setup but when I got to following the
Mythtv XMLTV wiki install instructions it fails on the first step
(below) with a can't authenticate server offline message

tv_grab_zz_sdjson_sqlite --manage-lineups --config-file $HOME/.mythtv/SD.xmltv

On 4/20/20, Jim Abernathy <jfabernathy@gmail.com> wrote:
>
> At this point I think we all can assume it's the server issue, but to
> confirm a different way I did a fresh install of Raspbian buster on a
> RPi4 and went thru my normal setup but when I got to following the
> Mythtv XMLTV wiki install instructions it fails on the first step
> (below) with a can't authenticate server offline message
>
> tv_grab_zz_sdjson_sqlite --manage-lineups --config-file
> $HOME/.mythtv/SD.xmltv
>
>

It looks like things should be working though performance will be a
bit slow for a bit:

https://forums.schedulesdirect.org/viewtopic.php?f=18&t=3065

I was able to run mythfildatabase successfully at 3:10 PM EDT today
and it worked but did take much longer to run the grabber than usual.

Tom
_______________________________________________
mythtv-users mailing list
mythtv-users@mythtv.org
http://lists.mythtv.org/mailman/listinfo/mythtv-users
http://wiki.mythtv.org/Mailing_List_etiquette
MythTV Forums: https://forum.mythtv.org