[LON-CAPA-admin] lonnet error messages

Stuart Raeburn raeburn at msu.edu
Mon Sep 22 14:50:01 EDT 2014


Hi Hon-Kie,

Thanks for providing the complete entries from lonnet.log for the  
"Failed to transfer" messages.  That tells me that this message is  
being logged by the
removefile() routine in:

/home/httpd/lib/perl/Apache/lontokacc.pm

That routine is called as a PerlCleanupHandler (i.e., at the very end  
of handling of a request).  The requet itself occurs when a file in  
/userfiles/ is requested by an LWP request within the  
fetch_user_file_handler() routine in lond. fetch_user_file_handler()  
is called to handle a "fetchuserfile" command, which occurs, for  
example, when a Course Coordinator creates a new folder in the Course  
Editor in a session hosted on the library server.

If you have any recent instances of "Failed to transfer <some file in  
userfiles> in your lonnet.log file (without any trailing: 'to host
<home> : <error>') you might look in your Apache log files  
(/etc/httpd/logs/ssl_access.log) to see what the return code from  
Apache was for the corresponding LWP request.

lontokacc::remove() will log a "Failed to transfer" record in  
lonnet.log whenever the request status is other than 200 (OK).

In any event, the failure of lontokacc::remove() to run means that a  
file such as:

/home/httpd/html/userfiles/fsu/1c22903f4adf4530afsul/default_1156334647.sequence

on your library server will not have been unlinked, as part of the  
cleanup phase.

Note: the corresponding permanent file in:

/home/httpd/lonUsers/fsu/1/c/2/1c22903f4adf4530afsul/userfiles/default_1156334647.sequence

is the one that needs to be preserved.  You might check if that file exists.


Stuart Raeburn
LON-CAPA Academic Consortium


Quoting "H. K. Ng" <hkng at fsu.edu>:

> Hi Stuart,
>
>
> As regards the "Failed to transfer" messages logged in lonnet.log,
>> could you provide the last part of the log message (i.e, the 'to host
>> <home> : <error>' portion.  I am interested in the error message (if
>> any) after the final colon.
>>
>
> Here is the complete entries in around the "Failed" message
>
> Tue Sep  9 09:12:56 2014 (21680): SSO authorized user xxx
> Tue Sep  9 09:12:56 2014 (21680): Allowing access for xxx:fsu to
> Tue Sep  9 09:14:08 2014 (22803): Failed to transfer
> https://loncapa10.fsu.edu/userfiles/fsu/1c22903f4adf4530afsul1/default_1156334647.sequence
> Tue Sep  9 09:20:17 2014 (23192): <font color="yellow">INFO: Read
> configuration</font>
> Tue Sep  9 09:20:17 2014 (23192):  Detected 64bit platform (1)
> Tue Sep  9 09:20:24 2014 (21679): Failed to transfer
> https://loncapa10.fsu.edu/userfiles/fsu/1c22903f4adf4530afsul1/default_1106679
> 36698591156334700.sequence
> Tue Sep  9 09:21:17 2014 (23201): Trying to reconnect lonc for authorl1 (
> educog.com)
>
> ...
>
> Tue Sep  9 09:22:52 2014 (22159): SSO authorized user xxx
> Tue Sep  9 09:22:52 2014 (22159): Allowing access for xxx:fsu to
> Tue Sep  9 09:23:14 2014 (23259): <font color="yellow">INFO: Read
> configuration</font>
> Tue Sep  9 09:23:14 2014 (23259):  Detected 64bit platform (1)
> Tue Sep  9 09:23:14 2014 (23259): <span style='color:yellow;'>INFO: Read
> file types</span>
> Tue Sep  9 09:23:39 2014 (23222): Failed to transfer
> https://loncapa10.fsu.edu/userfiles/fsu/1c22903f4adf4530afsul1/default_110667936698591156334700.sequence
> Tue Sep  9 09:28:52 2014 (22803): Allowing access for yyy:fsu to
>
> I don't see any "to host" entries. These messages are not related to the
> cloning of a course, more like routine access to a course material. The
> messages are not limited to one course. So far no faculty has said anything
> to me about problems accessing with their course materials. So the messages
> may not point to any "real" error though my concern is that they may not
> have noticed(??).
>
>
>
>> At the same time could you look in /home/httpd/perl/logs/lond.log on
>> loncapa10.fsu.edu for logged entries from the
>> "fetch_user_file_handler() routine in lond which might have been
>> written during this failed upload.
>>
>
> There doesn't appear to be any entries in the lond.log or lond_error file
> at around the same time.
>
>
>>
>> > https://loncapa10.fsu.edu/userfiles/fsu/......
>>
>> Is the lonnet.log file with this error on the access server or the
>> library server?
>>
>
> They appear on the library server only.
>
>
>
>>
>> In your earlier post --
>> http://mail.lon-capa.org/pipermail/lon-capa-admin/2014-August/002890.html
>> --
>> these errors were for sequence files during cloning, is that still the
>> case, or is the latest failure for different file(s) (in different
>> context(s)?
>>
>
> See above - in the cloning process there are a whole list (~10-20) entries
> but now there are intermittent.
>
>
> Thanks,
> -hk
>
>
>
>
>> loncapa10.fsu.edu now has a valid ssl certificate but the message still
>> > appears. Any idea why this is happening?
>> >
>> > Example:
>> > Tue Sep  9 09:14:08 2014 (22803): Failed to transfer
>> > https://loncapa10.fsu.edu/userfiles/fsu/......
>> >
>> > Thanks,
>> > -hk
>> >
>> >
>> >
>> >
>> > On Tue, Aug 19, 2014 at 9:51 AM, Stuart Raeburn <raeburn at msu.edu> wrote:
>> >
>> >> Hi Hon-Kie,
>> >>
>> >> Could you update the Apache SSL certificate on loncapa10.fsu.edu?
>> >> The certificate currently installed on that server expired on 2/5/2014
>> >>
>> >> Thanks,
>> >>
>> >> Stuart Raeburn
>> >> LON-CAPA Academic Consortium
>> >>
>> >>
>> >> Quoting "H. K. Ng" <hkng at fsu.edu>:
>> >>
>> >> > Hi,
>> >> >
>> >> > lonnet.log contains lots of entries like
>> >> >
>> >> > Mon Aug 18 15:19:36 2014 (26005): Failed to transfer
>> >> > https://loncapa10.fsu.edu/userfiles/fsu/
>> >> > <courseid>/default_1194996788.sequence
>> >> > Mon Aug 18 15:19:36 2014 (25997): Failed to transfer
>> >> > https://loncapa10.fsu.edu/userfiles/fsu/
>> >> > <courseid>/default_1126798332194021220046396.sequence
>> >> > Mon Aug 18 15:19:36 2014 (27247): Failed to transfer
>> >> > https://loncapa10.fsu.edu/userfiles/fsu/
>> >> > <courseid>/default_1126538470221341171395476.sequence
>> >> > Mon Aug 18 15:19:36 2014 (25998): Failed to transfer
>> >> > https://loncapa10.fsu.edu/userfiles/fsu/
>> >> > <courseid>/default_1194996854199511220047748.sequence
>> >> > Mon Aug 18 15:19:36 2014 (26006): Failed to transfer
>> >> > https://loncapa10.fsu.edu/userfiles/fsu/
>> >> > <courseid>/default_1194367929194031220047675.sequence
>> >> > Mon Aug 18 15:19:36 2014 (26002): Failed to transfer
>> >> > https://loncapa10.fsu.edu/userfiles/fsu/
>> >> > <courseid>/default_1076009816173961157646130.sequence
>> >> > Mon Aug 18 15:19:36 2014 (27248): Failed to transfer
>> >> > https://loncapa10.fsu.edu/userfiles/fsu/1
>> >> > <courseid>/default_1125678015221301171395436.sequence
>> >> >
>> >> > As far as I could determine, the messages appear when a course is
>> cloned.
>> >> > Does this mean that some of the sequences are not cloned over? Any
>> cause
>> >> > for concern?
>> >> >
>> >> > Thanks,
>> >> > -hk
>> >>
>> >> _______________________________________________
>> >> LON-CAPA-admin mailing list
>> >> LON-CAPA-admin at mail.lon-capa.org
>> >> http://mail.lon-capa.org/mailman/listinfo/lon-capa-admin
>>
>> _______________________________________________
>> LON-CAPA-admin mailing list
>> LON-CAPA-admin at mail.lon-capa.org
>> http://mail.lon-capa.org/mailman/listinfo/lon-capa-admin



More information about the LON-CAPA-admin mailing list