[mythtv-users] XMLTV failure after update today
Jim Abernathy
jfabernathy at gmail.com
Sun Apr 19 11:10:17 UTC 2020
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 at 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
>
More information about the mythtv-users
mailing list