SCORMs log message"Did not override time, saving incremental time"
Mar 12, 2013
Hi.
Well, this is frustrating. I started having problems with several SCORMs packages (version 1.2) created in Articulate presenter 09 and quizmaker. My LMS WAS Moodle (version 1.9). I asked technical support to the Articulate reseller in my country and the recommendation was to migrate to Moodle 2.4. I already did it and the problems persists. I enabled LMS debug mode in the SCORMs and executed on Moodle as well as on RELOAD-Player. Same result... At some point the SCORM has problems managing time (or something like that) because it sends in the logfile "Did not override time, saving incremental time" then starts doing some calculations with the time/hour. When the SCORM is executed in Moodle, the error provokes an stop or lost of sincronization in the tracking of "viewed slides". Also the student will loose the quizz result.
The following lines are from the logfile, please look at line 547.
533:Tue Mar 12 2013 10:51:19 GMT-0600 - In SetDataChunk strData=viewed=1,2,3,8,10,11,12,14,19,20,21,22,25,29,30,31,32,33,34|lastviewedslide=34|33#1##,7,7,23,0,0,0,0,2,16,22,22,3,0,2,0,0,0,16,22,23,23,7,0,0,2,0,0,16,22,23,23,23,23,27,1,0,1,0,0,0,0,0,1,0,0,0,0,0,0,0,0,0,0,1,0,0,0,0,0,0,0,0,0,0,0,1,0,0,0,0,0,0,0,0,1,1,1#0##-1
534:Tue Mar 12 2013 10:51:19 GMT-0600 - In ClearErrorInfo
535:Tue Mar 12 2013 10:51:19 GMT-0600 - In IsLoaded, returning -true
536:Tue Mar 12 2013 10:51:19 GMT-0600 - In SCORM_SetDataDChunk
537:Tue Mar 12 2013 10:51:19 GMT-0600 - In SCORM_ClearErrorInfo
538:Tue Mar 12 2013 10:51:19 GMT-0600 - SCORM_CallLMSSetValue strElement=cmi.suspend_data, strValue=viewed=1,2,3,8,10,11,12,14,19,20,21,22,25,29,30,31,32,33,34|lastviewedslide=34|33#1##,7,7,23,0,0,0,0,2,16,22,22,3,0,2,0,0,0,16,22,23,23,7,0,0,2,0,0,16,22,23,23,23,23,27,1,0,1,0,0,0,0,0,1,0,0,0,0,0,0,0,0,0,0,1,0,0,0,0,0,0,0,0,0,0,0,1,0,0,0,0,0,0,0,0,1,1,1#0##-1
539:Tue Mar 12 2013 10:51:19 GMT-0600 - In SCORM_GrabAPI
540:Tue Mar 12 2013 10:51:19 GMT-0600 - SCORM_GrabAPI, returning
541:Tue Mar 12 2013 10:51:19 GMT-0600 - Calling LMSSetValue
542:Tue Mar 12 2013 10:51:19 GMT-0600 - strResult=true
543:Tue Mar 12 2013 10:51:19 GMT-0600 - Returning true
544:Tue Mar 12 2013 10:51:19 GMT-0600 - In CommitData
545:Tue Mar 12 2013 10:51:19 GMT-0600 - In ClearErrorInfo
546:Tue Mar 12 2013 10:51:19 GMT-0600 - In IsLoaded, returning -true
547:Tue Mar 12 2013 10:51:19 GMT-0600 - Did not override time, saving incremental time
548:Tue Mar 12 2013 10:51:19 GMT-0600 - In AccumulateTime dtmStart=Tue Mar 12 2013 10:41:19 GMT-0600 dtmEnd=Tue Mar 12 2013 10:51:19 GMT-0600 intAccumulatedMS=247
549:Tue Mar 12 2013 10:51:19 GMT-0600 - Accumulating Time
550:Tue Mar 12 2013 10:51:19 GMT-0600 - intAccumulatedMS=600210
551:Tue Mar 12 2013 10:51:19 GMT-0600 - In SCORM_SaveTime intMilliSeconds=600210
552:Tue Mar 12 2013 10:51:19 GMT-0600 - In SCORM_ClearErrorInfo
553:Tue Mar 12 2013 10:51:19 GMT-0600 - In ConvertMilliSecondsIntoSCORMTime, intTotalMilliseconds = 600210, blnIncludeFraction = true
554:Tue Mar 12 2013 10:51:19 GMT-0600 - Separated Parts, intHours=0, intMinutes=10, intSeconds=0, intMilliseconds=210
555:Tue Mar 12 2013 10:51:19 GMT-0600 - In ZeroPad intNum=0 intNumDigits=4
556:Tue Mar 12 2013 10:51:19 GMT-0600 - Returning - 0000
557:Tue Mar 12 2013 10:51:19 GMT-0600 - In ZeroPad intNum=10 intNumDigits=2
558:Tue Mar 12 2013 10:51:19 GMT-0600 - Returning - 10
559:Tue Mar 12 2013 10:51:19 GMT-0600 - In ZeroPad intNum=0 intNumDigits=2
560:Tue Mar 12 2013 10:51:19 GMT-0600 - Returning - 00
561:Tue Mar 12 2013 10:51:19 GMT-0600 - strCMITimeSpan=0000:10:00.21
562:Tue Mar 12 2013 10:51:19 GMT-0600 - returning 0000:10:00.21
563:Tue Mar 12 2013 10:51:19 GMT-0600 - strCMITime=0000:10:00.21
564:Tue Mar 12 2013 10:51:19 GMT-0600 - SCORM_CallLMSSetValue strElement=cmi.core.session_time, strValue=0000:10:00.21
565:Tue Mar 12 2013 10:51:19 GMT-0600 - In SCORM_GrabAPI
566:Tue Mar 12 2013 10:51:19 GMT-0600 - SCORM_GrabAPI, returning
567:Tue Mar 12 2013 10:51:19 GMT-0600 - Calling LMSSetValue
568:Tue Mar 12 2013 10:51:19 GMT-0600 - strResult=true
569:Tue Mar 12 2013 10:51:19 GMT-0600 - Returning true
570:Tue Mar 12 2013 10:51:19 GMT-0600 - In SCORM_CommitData
571:Tue Mar 12 2013 10:51:19 GMT-0600 - In SCORM_ClearErrorInfo
572:Tue Mar 12 2013 10:51:19 GMT-0600 - In SCORM_CallLMSCommit
573:Tue Mar 12 2013 10:51:19 GMT-0600 - In SCORM_GrabAPI
574:Tue Mar 12 2013 10:51:19 GMT-0600 - SCORM_GrabAPI, returning
575:Tue Mar 12 2013 10:51:19 GMT-0600 - Calling LMSCommit
576:Tue Mar 12 2013 10:51:19 GMT-0600 - strResult=true
577:Tue Mar 12 2013 10:51:19 GMT-0600 - Returning true
578:Tue Mar 12 2013 10:52:25 GMT-0600 - In SetDataChunk strData=viewed=1,2,3,8,10,11,12,14,19,20,21,22,25,29,30,31,32,33,34|lastviewedslide=34|34#1##,7,7,23,0,0,0,0,2,16,22,22,3,0,2,0,0,0,16,22,23,23,7,0,0,2,0,0,16,22,23,23,23,23,31,1,0,1,0,0,0,0,0,1,0,0,0,0,0,0,0,0,0,0,1,0,0,0,0,0,0,0,0,0,0,0,1,0,0,0,0,0,0,0,0,1,1,1#0##-1
579:Tue Mar 12 2013 10:52:25 GMT-0600 - In ClearErrorInfo
580:Tue Mar 12 2013 10:52:25 GMT-0600 - In IsLoaded, returning -true
581:Tue Mar 12 2013 10:52:25 GMT-0600 - In SCORM_SetDataDChunk
582:Tue Mar 12 2013 10:52:25 GMT-0600 - In SCORM_ClearErrorInfo
583:Tue Mar 12 2013 10:52:25 GMT-0600 - SCORM_CallLMSSetValue strElement=cmi.suspend_data, strValue=viewed=1,2,3,8,10,11,12,14,19,20,21,22,25,29,30,31,32,33,34|lastviewedslide=34|34#1##,7,7,23,0,0,0,0,2,16,22,22,3,0,2,0,0,0,16,22,23,23,7,0,0,2,0,0,16,22,23,23,23,23,31,1,0,1,0,0,0,0,0,1,0,0,0,0,0,0,0,0,0,0,1,0,0,0,0,0,0,0,0,0,0,0,1,0,0,0,0,0,0,0,0,1,1,1#0##-1
584:Tue Mar 12 2013 10:52:25 GMT-0600 - In SCORM_GrabAPI
585:Tue Mar 12 2013 10:52:25 GMT-0600 - SCORM_GrabAPI, returning
586:Tue Mar 12 2013 10:52:25 GMT-0600 - Calling LMSSetValue
587:Tue Mar 12 2013 10:52:25 GMT-0600 - strResult=true
588:Tue Mar 12 2013 10:52:25 GMT-0600 - Returning true
8 Replies
Hi Jose,
I'd be curious to know if you get the same errors if you test it in SCORM Cloud? Would you mind testing your course in SCORM Cloud to help us determine if the issue is Articulate-related or if it's on your LMS's side? If it appears in SCORM Cloud as well, we'd be happy to take a closer look at what might be going on. If you can't replicate the issue in SCORM Cloud, it's probably an issue that you'd want to take to your LMS team. The articles here and here may also help clear up common LMS issues.
Thanks, Jose! Let us know what you discover...
Hi Peter.
Unfortunately I can't post the course in SCORM cloud since it has sensitive information. The good news is that finally Moodle is saving all SCORM data. I decided to start from a "white sheet of paper": I read the articles you recommended, I also found information about compatibility issues in IE9 and the way to fix it. Republished SCORMs using reporting status as passed/incomplete. Uploaded and tested in Moodle 2.4 and works fine.
I have to test more scenarios but at this time the SCORMs in moodle are working correctly
Good news, Jose. Glad to hear it
Keep us posted as you go...
Take care!
I did the test in 8 computers and all is working fine. Moodle saves grades and visited slides.
Just one thing, I asked co-workers help me doing the clics in one of the SCORMs at the same time and in 3 out of 8 computers the outline tab did not load completely, just appears the navigation tab but in blanks. Moodle is running in a local server but the SCORM had several videos. Any idea? (the net, the SCORM, the LMS)
Thanks for all Peter.
Hi Jose,
Can you provide a screenshot or a link to the course so we can get a better idea of the blank navigation tab you're describing?
Thanks!
Hi Peter.
I'll try to replicate the error... if I get it, i'll send the screen.
Thanks !
Hi Team,
I am facing the same issue on the latest stable version of Moodle i.e. 3.9.2.
I have published the course with SCORM 1.2 and with the mentioned setting of "reporting status as passed/incomplete".
My LMS package is sending the suspend data, (which I can check through the logs) but it is not getting stored in the LMS/database. Rather it is getting stored after some delay of say 30 seconds to minute time.
I also checked the course on SCORM cloud. Bookmarking is working fine as expected on SCORM cloud.
Hi Sameer!
Sorry you're running into this issue! Since the course is working as expected in SCORM cloud, I'd recommend reaching out to Moodle to see if they have any troubleshooting tips. Please keep us updated in this discussion!
If there's anything we can help with, feel free to connect with our Support Engineers here.
This discussion is closed. You can start a new discussion or contact Articulate Support.