2010-02-24 06:06:02.422 Using runtime prefix = /usr/local
2010-02-24 06:06:02.422 Using configuration directory = /home/mythtv/.mythtv
2010-02-24 06:06:02.423 Empty LocalHostName.
2010-02-24 06:06:02.423 Using localhost value of mythtv
2010-02-24 06:06:02.430 New DB connection, total: 1
2010-02-24 06:06:02.435 Connected to database 'mythconverg' at host: localhost
2010-02-24 06:06:02.435 Closing DB connection named 'DBManager0'
2010-02-24 06:06:02.436 Connected to database 'mythconverg' at host: localhost
2010-02-24 06:06:02.440 Current MythTV Schema Version (DBSchemaVer): 1244
2010-02-24 06:06:02.446 New DB connection, total: 2
2010-02-24 06:06:02.447 Connected to database 'mythconverg' at host: localhost
2010-02-24 06:06:02.450 mythfilldatabase: Listings Download Started
2010-02-24 06:06:02.786 Updating source #1 (comcast) with grabber schedulesdirect1
2010-02-24 06:06:02.787 Found 66 channels for source 1 which use grabber
2010-02-24 06:06:02.787
2010-02-24 06:06:02.787 Checking day @ offset 0, date: Wed Feb 24 2010
2010-02-24 06:06:02.896 Data is already present for Wed Feb 24 2010, skipping
2010-02-24 06:06:02.896
2010-02-24 06:06:02.896 Checking day @ offset 1, date: Thu Feb 25 2010
2010-02-24 06:06:02.896 Data Refresh always needed for tomorrow
2010-02-24 06:06:02.896 Refreshing data for Thu Feb 25 2010
2010-02-24 06:06:02.896 This DataDirect listings source is shared by 2 MythTV lineups
2010-02-24 06:06:02.896 We should keep data around after this one
2010-02-24 06:06:02.896 New DB DataDirect connection
2010-02-24 06:06:02.897 Connected to database 'mythconverg' at host: localhost
2010-02-24 06:06:02.898 Retrieving datadirect data.
2010-02-24 06:06:02.899 Grabbing data for Wed Feb 24 2010 offset 1
2010-02-24 06:06:02.899 From Thu Feb 25 05:00:00 2010 to Fri Feb 26 05:00:00 2010 (UTC)
2010-02-24 06:06:02.899 Grabbing listing data
--2010-02-24 06:06:02-- http://webservices.schedulesdirect.tmsdatadirect.com/schedulesdirect/tvlistings/xtvdService
Resolving webservices.schedulesdirect.tmsdatadirect.com... 2010-02-24 06:06:02.909 DataDirect: Saving listings to DD cache
144.142.232.53
Connecting to webservices.schedulesdirect.tmsdatadirect.com|144.142.232.53|:80... connected.
HTTP request sent, awaiting response... 401 Unauthorized
Reusing existing connection to webservices.schedulesdirect.tmsdatadirect.com:80.
HTTP request sent, awaiting response... 200 OK
Length: unspecified [text/xml]
Saving to: `STDOUT'
[ <=> ] 212,623 36.2K/s in 17s
2010-02-24 06:06:21 (12.0 KB/s) - `-' saved [212623]
2010-02-24 06:06:21.075 New DB connection, total: 3
2010-02-24 06:06:21.075 Connected to database 'mythconverg' at host: localhost
2010-02-24 06:06:21.078 DataDirect: Your subscription expires on Sat Jun 19 10:42 PM
2010-02-24 06:06:21.188 sourceid 1 has lineup type: Cable
2010-02-24 06:06:32.096 Grab complete. Actual data from Thu Feb 25 05:00:00 2010 to Fri Feb 26 05:00:00 2010 (UTC)
2010-02-24 06:06:32.096 Main temp tables populated.
2010-02-24 06:06:32.096 Updating myth channels.
2010-02-24 06:06:32.110 IconData: Updating icons for sourceid: 1
2010-02-24 06:06:32.111 Channels updated.
2010-02-24 06:06:32.332 Clearing data for source.
2010-02-24 06:06:32.333 Clearing from Thu Feb 25 00:00:00 2010 to Fri Feb 26 00:00:00 2010 (localtime)
2010-02-24 06:06:34.028 Data for source cleared.
2010-02-24 06:06:34.028 Updating programs.
2010-02-24 06:06:36.567 Program table update complete.
2010-02-24 06:06:36.567
2010-02-24 06:06:36.567 Checking day @ offset 2, date: Fri Feb 26 2010
2010-02-24 06:06:36.676 Data is already present for Fri Feb 26 2010, skipping
2010-02-24 06:06:36.677
2010-02-24 06:06:36.677 Checking day @ offset 3, date: Sat Feb 27 2010
2010-02-24 06:06:36.794 Data is already present for Sat Feb 27 2010, skipping
2010-02-24 06:06:36.795
2010-02-24 06:06:36.795 Checking day @ offset 4, date: Sun Feb 28 2010
2010-02-24 06:06:36.899 Data is already present for Sun Feb 28 2010, skipping
2010-02-24 06:06:36.899
2010-02-24 06:06:36.899 Checking day @ offset 5, date: Mon Mar 1 2010
2010-02-24 06:06:37.002 Data is already present for Mon Mar 1 2010, skipping
2010-02-24 06:06:37.002
2010-02-24 06:06:37.002 Checking day @ offset 6, date: Tue Mar 2 2010
2010-02-24 06:06:37.107 Data is already present for Tue Mar 2 2010, skipping
2010-02-24 06:06:37.107
2010-02-24 06:06:37.107 Checking day @ offset 7, date: Wed Mar 3 2010
2010-02-24 06:06:37.230 Data is already present for Wed Mar 3 2010, skipping
2010-02-24 06:06:37.230
2010-02-24 06:06:37.230 Checking day @ offset 8, date: Thu Mar 4 2010
2010-02-24 06:06:37.330 Data is already present for Thu Mar 4 2010, skipping
2010-02-24 06:06:37.331
2010-02-24 06:06:37.331 Checking day @ offset 9, date: Fri Mar 5 2010
2010-02-24 06:06:37.430 Data is already present for Fri Mar 5 2010, skipping
2010-02-24 06:06:37.430
2010-02-24 06:06:37.430 Checking day @ offset 10, date: Sat Mar 6 2010
2010-02-24 06:06:37.529 Data is already present for Sat Mar 6 2010, skipping
2010-02-24 06:06:37.529
2010-02-24 06:06:37.529 Checking day @ offset 11, date: Sun Mar 7 2010
2010-02-24 06:06:37.626 Data is already present for Sun Mar 7 2010, skipping
2010-02-24 06:06:37.626
2010-02-24 06:06:37.626 Checking day @ offset 12, date: Mon Mar 8 2010
2010-02-24 06:06:37.722 Data is already present for Mon Mar 8 2010, skipping
2010-02-24 06:06:37.722
2010-02-24 06:06:37.722 Checking day @ offset 13, date: Tue Mar 9 2010
2010-02-24 06:06:37.818 Data is already present for Tue Mar 9 2010, skipping
2010-02-24 06:06:38.207 Updating source #2 (comcast-digital) with grabber schedulesdirect1
2010-02-24 06:06:38.211 Found 11 channels for source 2 which use grabber
2010-02-24 06:06:38.211
2010-02-24 06:06:38.211 Checking day @ offset 0, date: Wed Feb 24 2010
2010-02-24 06:06:38.231 Data is already present for Wed Feb 24 2010, skipping
2010-02-24 06:06:38.231
2010-02-24 06:06:38.231 Checking day @ offset 1, date: Thu Feb 25 2010
2010-02-24 06:06:38.231 Data Refresh always needed for tomorrow
2010-02-24 06:06:38.232 Refreshing data for Thu Feb 25 2010
2010-02-24 06:06:38.232 This DataDirect listings source is shared by 2 MythTV lineups
2010-02-24 06:06:38.232 We should use cached data for this one
2010-02-24 06:06:38.233 Retrieving datadirect data.
2010-02-24 06:06:38.233 Grabbing data for Wed Feb 24 2010 offset 1
2010-02-24 06:06:38.233 From Thu Feb 25 05:00:00 2010 to Fri Feb 26 05:00:00 2010 (UTC)
2010-02-24 06:06:38.233 Grabbing listing data
2010-02-24 06:06:38.233 DataDirect: Copying from DD cache
2010-02-24 06:06:38.246 DataDirect: Your subscription expires on Sat Jun 19 10:42 PM
2010-02-24 06:06:49.297 Grab complete. Actual data from Thu Feb 25 05:00:00 2010 to Fri Feb 26 05:00:00 2010 (UTC)
2010-02-24 06:06:49.298 Main temp tables populated.
2010-02-24 06:06:49.298 Updating myth channels.
2010-02-24 06:06:49.349 IconData: Updating icons for sourceid: 2
2010-02-24 06:06:49.351 Channels updated.
2010-02-24 06:06:49.506 Clearing data for source.
2010-02-24 06:06:49.506 Clearing from Thu Feb 25 00:00:00 2010 to Fri Feb 26 00:00:00 2010 (localtime)
2010-02-24 06:06:49.800 Data for source cleared.
2010-02-24 06:06:49.800 Updating programs.
2010-02-24 06:06:50.354 Program table update complete.
2010-02-24 06:06:50.355
2010-02-24 06:06:50.355 Checking day @ offset 2, date: Fri Feb 26 2010
2010-02-24 06:06:50.374 Data is already present for Fri Feb 26 2010, skipping
2010-02-24 06:06:50.375
2010-02-24 06:06:50.375 Checking day @ offset 3, date: Sat Feb 27 2010
2010-02-24 06:06:50.395 Data is already present for Sat Feb 27 2010, skipping
2010-02-24 06:06:50.395
2010-02-24 06:06:50.395 Checking day @ offset 4, date: Sun Feb 28 2010
2010-02-24 06:06:50.413 Data is already present for Sun Feb 28 2010, skipping
2010-02-24 06:06:50.413
2010-02-24 06:06:50.413 Checking day @ offset 5, date: Mon Mar 1 2010
2010-02-24 06:06:50.434 Data is already present for Mon Mar 1 2010, skipping
2010-02-24 06:06:50.434
2010-02-24 06:06:50.434 Checking day @ offset 6, date: Tue Mar 2 2010
2010-02-24 06:06:50.454 Data is already present for Tue Mar 2 2010, skipping
2010-02-24 06:06:50.454
2010-02-24 06:06:50.454 Checking day @ offset 7, date: Wed Mar 3 2010
2010-02-24 06:06:50.473 Data is already present for Wed Mar 3 2010, skipping
2010-02-24 06:06:50.473
2010-02-24 06:06:50.473 Checking day @ offset 8, date: Thu Mar 4 2010
2010-02-24 06:06:50.493 Data is already present for Thu Mar 4 2010, skipping
2010-02-24 06:06:50.493
2010-02-24 06:06:50.493 Checking day @ offset 9, date: Fri Mar 5 2010
2010-02-24 06:06:50.511 Data is already present for Fri Mar 5 2010, skipping
2010-02-24 06:06:50.511
2010-02-24 06:06:50.511 Checking day @ offset 10, date: Sat Mar 6 2010
2010-02-24 06:06:50.533 Data is already present for Sat Mar 6 2010, skipping
2010-02-24 06:06:50.534
2010-02-24 06:06:50.534 Checking day @ offset 11, date: Sun Mar 7 2010
2010-02-24 06:06:50.553 Data is already present for Sun Mar 7 2010, skipping
2010-02-24 06:06:50.553
2010-02-24 06:06:50.553 Checking day @ offset 12, date: Mon Mar 8 2010
2010-02-24 06:06:50.570 Data is already present for Mon Mar 8 2010, skipping
2010-02-24 06:06:50.570
2010-02-24 06:06:50.570 Checking day @ offset 13, date: Tue Mar 9 2010
2010-02-24 06:06:50.588 Data is already present for Tue Mar 9 2010, skipping
2010-02-24 06:06:50.646 Data fetching complete.
2010-02-24 06:06:50.647 Adjusting program database end times.
2010-02-24 06:06:52.537 0 replacements made
2010-02-24 06:06:52.540 mythfilldatabase: Listings Download Finished
2010-02-24 06:06:52.540 Marking generic episodes.
2010-02-24 06:06:52.979 Found 529
2010-02-24 06:06:52.979 Fudging non-unique programids with multiple parts.
2010-02-24 06:06:53.081 Found 0
2010-02-24 06:06:53.081 Marking repeats.
2010-02-24 06:06:53.548 Found 1530
2010-02-24 06:06:53.548 Unmarking new episode rebroadcast repeats.
2010-02-24 06:06:53.920 Found 0
2010-02-24 06:06:54.653 Marking episode first showings.
2010-02-24 06:07:09.491 Found 16721
2010-02-24 06:07:09.491 Marking episode last showings.
2010-02-24 06:07:23.983 Found 16721
2010-02-24 06:07:24.006
===============================================================
| Attempting to contact the master backend for rescheduling. |
| If the master is not running, rescheduling will happen when |
| the master backend is restarted. |
===============================================================
2010-02-24 06:07:24.014 MythContext: Connecting to backend server: 192.168.11.3:6543 (try 1 of 1)
2010-02-24 06:07:24.015 MythSocket(977ca48:10): new socket
2010-02-24 06:07:24.015 MythSocket(977ca48:10): attempting connect() to (192.168.11.3:6543)
2010-02-24 06:07:24.015 MythSocket(977ca48:10): state change Idle -> Connected
2010-02-24 06:07:24.015 MythSocket(977ca48:10): write -> 10 21 MYTH_PROTO_VERSION 50
2010-02-24 06:07:24.015 MythSocket(977ca48:10): writeBlock(0x158964648, 29)
2010-02-24 06:07:24.016 MythSocket(977ca48:10): readBlock(0x158829544, 8) called
2010-02-24 06:07:24.017 MythSocket(977ca48:10): readBlock(0x158725072, 13) called
2010-02-24 06:07:24.017 MythSocket(977ca48:10): read <- 10 13 ACCEPT[]:[]50
2010-02-24 06:07:24.017 Using protocol version 50
2010-02-24 06:07:24.017 MythSocket(977ca48:10): write -> 10 20 ANN Monitor mythtv 0
2010-02-24 06:07:24.017 MythSocket(977ca48:10): writeBlock(0x158846256, 28)
2010-02-24 06:07:24.020 MythSocket(977ca48:10): readBlock(0x158964800, 8) called
2010-02-24 06:07:24.020 MythSocket(977ca48:10): readBlock(0x158976376, 2) called
2010-02-24 06:07:24.020 MythSocket(977ca48:10): read <- 10 2 OK
2010-02-24 06:07:24.020 MythSocket(978c9a0:12): new socket
2010-02-24 06:07:24.020 MythSocket(978c9a0:12): attempting connect() to (192.168.11.3:6543)
2010-02-24 06:07:24.020 MythSocket(978c9a0:12): state change Idle -> Connected
2010-02-24 06:07:24.020 MythSocket(978c9a0:12): write -> 12 20 ANN Monitor mythtv 1
2010-02-24 06:07:24.020 MythSocket(978c9a0:12): writeBlock(0x158915640, 28)
2010-02-24 06:07:24.021 MythSocket(978c9a0:12): readBlock(0x158911424, 8) called
2010-02-24 06:07:24.022 MythSocket(978c9a0:12): readBlock(0x158984840, 2) called
2010-02-24 06:07:24.022 MythSocket(978c9a0:12): read <- 12 2 OK
2010-02-24 06:07:24.022 MythSocketThread: readyread thread start
2010-02-24 06:07:24.022 ProcessAddRemoveQueues
2010-02-24 06:07:24.022 Construct FD_SET
2010-02-24 06:07:24.022 Empty FD_SET, sleeping
2010-02-24 06:07:24.022 MythSocket(978c9a0:12): UpRef: 1
2010-02-24 06:07:24.022 MythSocket(977ca48:10): write -> 10 24 RESCHEDULE_RECORDINGS -1
2010-02-24 06:07:24.022 MythSocket(977ca48:10): writeBlock(0x158636440, 32)
2010-02-24 06:07:24.023 Empty FD_SET, woken up
2010-02-24 06:07:24.023 ProcessAddRemoveQueues
2010-02-24 06:07:24.023 Construct FD_SET
2010-02-24 06:07:24.023 Waiting on select..
2010-02-24 06:07:24.026 MythSocket(977ca48:10): readBlock(0x158554168, 8) called
2010-02-24 06:07:24.026 MythSocket(977ca48:10): readBlock(0x158914904, 1) called
2010-02-24 06:07:24.026 MythSocket(977ca48:10): read <- 10 1 1
2010-02-24 06:07:24.026 MythSocket(977ca48:10): write -> 10 32 MESSAGE[]:[]CLEAR_SETTINGS_CACHE
2010-02-24 06:07:24.026 MythSocket(977ca48:10): writeBlock(0x158915640, 40)
2010-02-24 06:07:24.038 Got data on select
2010-02-24 06:07:24.038 Processing ready reads
2010-02-24 06:07:24.038 MythSocketThread(sock 0x978c9a0:12): socket is readable
2010-02-24 06:07:24.038 MythSocketThread(sock 0x978c9a0:12): calling m_cb->readyRead()
2010-02-24 06:07:24.047 MythSocket(978c9a0:12): readBlock(0x158963480, 8) called
2010-02-24 06:07:24.047 MythSocket(978c9a0:12): readBlock(0x158963384, 50) called
2010-02-24 06:07:24.048 MythSocket(977ca48:10): readBlock(0x158554168, 8) called
2010-02-24 06:07:24.048 MythSocket(977ca48:10): readBlock(0x158914904, 2) called
2010-02-24 06:07:24.048 MythSocket(977ca48:10): read <- 10 2 OK
2010-02-24 06:07:24.048 MythSocket(977ca48:10): DownRef: -1
2010-02-24 06:07:24.048 MythSocket(977ca48:10): state change Connected -> Idle
2010-02-24 06:07:24.048 MSocketDevice::close: Closed socket 10
2010-02-24 06:07:24.048 MythSocket(977ca48:-1): delete socket
2010-02-24 06:07:24.048 MythSocket(978c9a0:12): DownRef: 0
2010-02-24 06:07:24.047 MythSocket(978c9a0:12): read <- 12 50 BACKEND_MESSAGE[]:[]CLEAR_SETTINGS_CACHE[]:[]empty
2010-02-24 06:07:24.052 Received a remote 'Clear Cache' request
QMutex::lock: mutex lock failure:
2010-02-24 06:07:24.062 mythfilldatabase run complete.
2010-02-24 06:07:24.062 DataDirect: Deleting temporary files
2010-02-24 06:07:24.517 MythHttpPool: RemoveListener(0xffffffffbfbba328)