Uploaded image for project: 'Moodle'
  1. Moodle
  2. MDL-62458

Remaining debugging in web server logs as of 3.5 release

    XMLWordPrintable

    Details

    • Type: Bug
    • Status: Open
    • Priority: Minor
    • Resolution: Unresolved
    • Affects Version/s: 3.5
    • Fix Version/s: None
    • Component/s: General, Lesson, SCORM, Workshop
    • Labels:
    • Affected Branches:
      MOODLE_35_STABLE

      Description

      Behat execution reveals a number of debugging messages sent to logs but not detected by behat (js...). This is a filter performed against a @javascript webeserver log:

      $ cat webserver | grep php7 | grep -v 'course.*view.php' | grep -v 'backup' | grep -v 'recyclebin' | more
       
      [Tue May 15 10:09:19.966614 2018] [php7:notice] [pid 504] [client 172.18.0.13:53008] Default exception handler: A required parameter (pageid) was missing Debug: \nError code: missingparam\n* line 482 of /lib/setuplib.php: moodle_exception thrown\n* line 573 of /lib/moodlelib.php: call to print_error()\n* line 31 of /mod/lesson/editpage.php: call to required_param()\n, referer: http://run8b23a742661b7534/behatrun2/mod/lesson/editpage.php
      [Tue May 15 10:09:20.230616 2018] [php7:notice] [pid 20] [client 172.18.0.13:53128] Default exception handler: A required parameter (pageid) was missing Debug: \nError code: missingparam\n* line 482 of /lib/setuplib.php: moodle_exception thrown\n* line 573 of /lib/moodlelib.php: call to print_error()\n* line 31 of /mod/lesson/editpage.php: call to required_param()\n, referer: http://run8b23a742661b7534/behatrun2/mod/lesson/editpage.php
      [Tue May 15 10:09:55.523855 2018] [php7:notice] [pid 519] [client 172.18.0.13:45096] Default exception handler: A required parameter (pageid) was missing Debug: \nError code: missingparam\n* line 482 of /lib/setuplib.php: moodle_exception thrown\n* line 573 of /lib/moodlelib.php: call to print_error()\n* line 31 of /mod/lesson/editpage.php: call to required_param()\n, referer: http://run8b23a742661b7534/behatrun2/mod/lesson/editpage.php
      [Tue May 15 10:09:55.777833 2018] [php7:notice] [pid 530] [client 172.18.0.13:45228] Default exception handler: A required parameter (pageid) was missing Debug: \nError code: missingparam\n* line 482 of /lib/setuplib.php: moodle_exception thrown\n* line 573 of /lib/moodlelib.php: call to print_error()\n* line 31 of /mod/lesson/editpage.php: call to required_param()\n, referer: http://run8b23a742661b7534/behatrun2/mod/lesson/editpage.php
      [Tue May 15 10:11:57.464723 2018] [php7:notice] [pid 526] [client 172.18.0.14:49540] Default exception handler: Invalid course module ID Debug: \nError code: invalidcoursemodule\n* line 482 of /lib/setuplib.php: moodle_exception thrown\n* line 27 of /mod/scorm/datamodel.php: call to print_error()\n, referer: http://run8b23a742661b7534/behatrun3/mod/scorm/player.php
      [Tue May 15 10:11:57.582593 2018] [php7:notice] [pid 526] [client 172.18.0.14:49540] Default exception handler: Invalid course module ID Debug: \nError code: invalidcoursemodule\n* line 482 of /lib/setuplib.php: moodle_exception thrown\n* line 41 of /mod/scorm/prereqs.php: call to print_error()\n, referer: http://run8b23a742661b7534/behatrun3/mod/scorm/player.php
      [Tue May 15 10:22:02.772396 2018] [php7:notice] [pid 570] [client 172.18.0.14:57696] Default exception handler: Invalid course module ID Debug: \nError code: invalidcoursemodule\n* line 482 of /lib/setuplib.php: moodle_exception thrown\n* line 27 of /mod/scorm/datamodel.php: call to print_error()\n, referer: http://run8b23a742661b7534/behatrun3/mod/scorm/player.php
      [Tue May 15 10:22:02.961890 2018] [php7:notice] [pid 570] [client 172.18.0.14:57696] Default exception handler: Invalid course module ID Debug: \nError code: invalidcoursemodule\n* line 482 of /lib/setuplib.php: moodle_exception thrown\n* line 41 of /mod/scorm/prereqs.php: call to print_error()\n, referer: http://run8b23a742661b7534/behatrun3/mod/scorm/player.php
      [Tue May 15 10:22:44.440609 2018] [php7:notice] [pid 635] [client 172.18.0.14:48538] Default exception handler: Invalid course module ID Debug: \nError code: invalidcoursemodule\n* line 482 of /lib/setuplib.php: moodle_exception thrown\n* line 27 of /mod/scorm/datamodel.php: call to print_error()\n, referer: http://run8b23a742661b7534/behatrun3/mod/scorm/player.php
      [Tue May 15 10:22:44.567264 2018] [php7:notice] [pid 635] [client 172.18.0.14:48538] Default exception handler: Invalid course module ID Debug: \nError code: invalidcoursemodule\n* line 482 of /lib/setuplib.php: moodle_exception thrown\n* line 41 of /mod/scorm/prereqs.php: call to print_error()\n, referer: http://run8b23a742661b7534/behatrun3/mod/scorm/player.php
      [Tue May 15 10:23:13.282657 2018] [php7:notice] [pid 635] [client 172.18.0.14:43820] Default exception handler: Invalid course module ID Debug: \nError code: invalidcoursemodule\n* line 482 of /lib/setuplib.php: moodle_exception thrown\n* line 27 of /mod/scorm/datamodel.php: call to print_error()\n, referer: http://run8b23a742661b7534/behatrun3/mod/scorm/player.php
      [Tue May 15 10:23:13.406054 2018] [php7:notice] [pid 635] [client 172.18.0.14:43820] Default exception handler: Invalid course module ID Debug: \nError code: invalidcoursemodule\n* line 482 of /lib/setuplib.php: moodle_exception thrown\n* line 41 of /mod/scorm/prereqs.php: call to print_error()\n, referer: http://run8b23a742661b7534/behatrun3/mod/scorm/player.php
      [Tue May 15 10:23:49.558317 2018] [php7:notice] [pid 666] [client 172.18.0.14:59352] Default exception handler: Invalid course module ID Debug: \nError code: invalidcoursemodule\n* line 482 of /lib/setuplib.php: moodle_exception thrown\n* line 27 of /mod/scorm/datamodel.php: call to print_error()\n, referer: http://run8b23a742661b7534/behatrun3/mod/scorm/player.php
      [Tue May 15 10:23:49.680493 2018] [php7:notice] [pid 666] [client 172.18.0.14:59352] Default exception handler: Invalid course module ID Debug: \nError code: invalidcoursemodule\n* line 482 of /lib/setuplib.php: moodle_exception thrown\n* line 41 of /mod/scorm/prereqs.php: call to print_error()\n, referer: http://run8b23a742661b7534/behatrun3/mod/scorm/player.php
      [Tue May 15 10:24:15.421851 2018] [php7:notice] [pid 643] [client 172.18.0.14:51286] Default exception handler: Invalid course module ID Debug: \nError code: invalidcoursemodule\n* line 482 of /lib/setuplib.php: moodle_exception thrown\n* line 37 of /mod/scorm/datamodel.php: call to print_error()\n, referer: http://run8b23a742661b7534/behatrun3/mod/scorm/player.php?a=370000&currentorg=golf_sample_default_org&scoid=372002&newattempt=on
      [Tue May 15 10:24:15.614594 2018] [php7:notice] [pid 643] [client 172.18.0.14:51286] Default exception handler: Invalid course module ID Debug: \nError code: invalidcoursemodule\n* line 482 of /lib/setuplib.php: moodle_exception thrown\n* line 41 of /mod/scorm/prereqs.php: call to print_error()\n, referer: http://run8b23a742661b7534/behatrun3/mod/scorm/player.php?a=370000&currentorg=golf_sample_default_org&scoid=372002&newattempt=on
      [Tue May 15 10:24:48.127837 2018] [php7:notice] [pid 608] [client 172.18.0.14:34922] Default exception handler: Invalid course module ID Debug: \nError code: invalidcoursemodule\n* line 482 of /lib/setuplib.php: moodle_exception thrown\n* line 37 of /mod/scorm/datamodel.php: call to print_error()\n, referer: http://run8b23a742661b7534/behatrun3/mod/scorm/player.php?a=370000&currentorg=golf_sample_default_org&scoid=372001&newattempt=on
      [Tue May 15 10:24:48.242529 2018] [php7:notice] [pid 608] [client 172.18.0.14:34922] Default exception handler: Invalid course module ID Debug: \nError code: invalidcoursemodule\n* line 482 of /lib/setuplib.php: moodle_exception thrown\n* line 41 of /mod/scorm/prereqs.php: call to print_error()\n, referer: http://run8b23a742661b7534/behatrun3/mod/scorm/player.php?a=370000&currentorg=golf_sample_default_org&scoid=372001&newattempt=on
      [Tue May 15 10:36:41.956803 2018] [php7:notice] [pid 769] [client 172.18.0.14:60714] Debugging: Invalid get_string() identifier: 'note' or component 'core_note'. Perhaps you are missing $string['note'] = ''; in lang/en/core_note.php? in \n* line 349 of /lib/classes/string_manager_standard.php: call to debugging()\n* line 117 of /lib/external/externallib.php: call to core_string_manager_standard->get_string()\n* line 228 of /lib/externallib.php: call to core_external::get_string()\n* line 59 of /lib/ajax/service.php: call to external_api::call_external_function()\n* line 31 of /lib/ajax/service-nologin.php: call to require_once()\n, referer: http://run8b23a742661b7534/behatrun3/user/index.php?id=100000
      [Tue May 15 10:39:07.815894 2018] [php7:notice] [pid 734] [client 172.18.0.12:37090] Default exception handler: Course or activity not accessible. Debug: You are not logged in\nError code: requireloginerror\n* line 2606 of /lib/moodlelib.php: require_login_exception thrown\n* line 69 of /lib/editor/atto/autosave-ajax.php: call to require_login()\n, referer: http://run8b23a742661b7534/behatrun1/course/edit.php?id=103000
      [Tue May 15 10:39:40.413634 2018] [php7:notice] [pid 763] [client 172.18.0.12:54588] Default exception handler: Course or activity not accessible. Debug: You are not logged in\nError code: requireloginerror\n* line 2606 of /lib/moodlelib.php: require_login_exception thrown\n* line 69 of /lib/editor/atto/autosave-ajax.php: call to require_login()\n, referer: http://run8b23a742661b7534/behatrun1/course/edit.php?id=103000
      [Tue May 15 11:00:03.028575 2018] [php7:notice] [pid 971] [client 172.18.0.13:36962] Default exception handler: A required parameter (cmid) was missing Debug: \nError code: missingparam\n* line 482 of /lib/setuplib.php: moodle_exception thrown\n* line 573 of /lib/moodlelib.php: call to print_error()\n* line 28 of /mod/workshop/submission.php: call to required_param()\n, referer: http://run8b23a742661b7534/behatrun2/mod/workshop/submission.php
      [Tue May 15 11:00:57.590144 2018] [php7:notice] [pid 955] [client 172.18.0.13:44012] Default exception handler: A required parameter (asid) was missing Debug: \nError code: missingparam\n* line 482 of /lib/setuplib.php: moodle_exception thrown\n* line 573 of /lib/moodlelib.php: call to print_error()\n* line 40 of /mod/workshop/assessment.php: call to required_param()\n, referer: http://run8b23a742661b7534/behatrun2/mod/workshop/assessment.php
      [Tue May 15 11:03:52.468296 2018] [php7:notice] [pid 993] [client 172.18.0.14:44560] Default exception handler: A required parameter (pageid) was missing Debug: \nError code: missingparam\n* line 482 of /lib/setuplib.php: moodle_exception thrown\n* line 573 of /lib/moodlelib.php: call to print_error()\n* line 31 of /mod/lesson/editpage.php: call to required_param()\n, referer: http://run8b23a742661b7534/behatrun3/mod/lesson/editpage.php
      [Tue May 15 11:03:52.777033 2018] [php7:notice] [pid 906] [client 172.18.0.14:44730] Default exception handler: A required parameter (pageid) was missing Debug: \nError code: missingparam\n* line 482 of /lib/setuplib.php: moodle_exception thrown\n* line 573 of /lib/moodlelib.php: call to print_error()\n* line 31 of /mod/lesson/editpage.php: call to required_param()\n, referer: http://run8b23a742661b7534/behatrun3/mod/lesson/editpage.php
      [Tue May 15 11:04:04.232170 2018] [php7:notice] [pid 961] [client 172.18.0.14:52008] Default exception handler: A required parameter (pageid) was missing Debug: \nError code: missingparam\n* line 482 of /lib/setuplib.php: moodle_exception thrown\n* line 573 of /lib/moodlelib.php: call to print_error()\n* line 31 of /mod/lesson/editpage.php: call to required_param()\n, referer: http://run8b23a742661b7534/behatrun3/mod/lesson/editpage.php
      [Tue May 15 11:04:04.530263 2018] [php7:notice] [pid 982] [client 172.18.0.14:52138] Default exception handler: A required parameter (pageid) was missing Debug: \nError code: missingparam\n* line 482 of /lib/setuplib.php: moodle_exception thrown\n* line 573 of /lib/moodlelib.php: call to print_error()\n* line 31 of /mod/lesson/editpage.php: call to required_param()\n, referer: http://run8b23a742661b7534/behatrun3/mod/lesson/editpage.php
      [Tue May 15 12:01:33.885469 2018] [php7:notice] [pid 1373] [client 172.18.0.12:32910] Debugging: Error: mdb->get_record() found more than one record! in \n* line 1583 of /lib/dml/moodle_database.php: call to debugging()\n* line 1543 of /lib/dml/moodle_database.php: call to moodle_database->get_record_sql()\n* line 1522 of /lib/dml/moodle_database.php: call to moodle_database->get_record_select()\n* line 1578 of /lib/filestorage/file_storage.php: call to moodle_database->get_record()\n* line 263 of /repository/repository_ajax.php: call to file_storage->create_file_from_reference()\n, referer: http://run8b23a742661b7534/behatrun1/course/modedit.php?add=folder&type=&course=103000&section=1&return=0&sr=0
      [Tue May 15 12:01:36.398579 2018] [php7:notice] [pid 1384] [client 172.18.0.12:33286] Default exception handler: A required parameter (id) was missing Debug: \nError code: missingparam\n* line 482 of /lib/setuplib.php: moodle_exception thrown\n* line 573 of /lib/moodlelib.php: call to print_error()\n* line 31 of /mod/folder/edit.php: call to required_param()\n, referer: http://run8b23a742661b7534/behatrun1/mod/folder/edit.php
      [Tue May 15 12:01:49.851278 2018] [php7:notice] [pid 1362] [client 172.18.0.12:38146] Default exception handler: A required parameter (id) was missing Debug: \nError code: missingparam\n* line 482 of /lib/setuplib.php: moodle_exception thrown\n* line 573 of /lib/moodlelib.php: call to print_error()\n* line 31 of /mod/folder/edit.php: call to required_param()\n, referer: http://run8b23a742661b7534/behatrun1/mod/folder/edit.php
      [Tue May 15 12:01:57.028028 2018] [php7:notice] [pid 1379] [client 172.18.0.12:42156] Debugging: Error: mdb->get_record() found more than one record! in \n* line 1583 of /lib/dml/moodle_database.php: call to debugging()\n* line 1543 of /lib/dml/moodle_database.php: call to moodle_database->get_record_sql()\n* line 1522 of /lib/dml/moodle_database.php: call to moodle_database->get_record_select()\n* line 1578 of /lib/filestorage/file_storage.php: call to moodle_database->get_record()\n* line 248 of /repository/repository_ajax.php: call to file_storage->create_file_from_reference()\n, referer: http://run8b23a742661b7534/behatrun1/mod/folder/edit.php
      

      They aren't too many cases, but happen a number of times, ideally we should be clean of them.

      Note the logs above DO NOT include @~javascript (goutte) runs. We should equeally llok there.

      Ciao

      PS: Affect 3.5 and, possibly, older branches too (haven't verified).

        Attachments

          Activity

            People

            • Assignee:
              Unassigned
              Reporter:
              stronk7 Eloy Lafuente (stronk7)
              Participants:
              Component watchers:
              Jake Dallimore, Jun Pataleta, Ryan Wyllie, Adrian Greeve, Mihail Geshoski, Peter Dias, Damyon Wiese, Dan Marsden, Matteo Scaramuccia, Adrian Greeve, Mihail Geshoski, Peter Dias, Amaia Anabitarte, Bas Brands, Carlos Escobedo, Sara Arjona (@sarjona), Víctor Déniz Falcón
            • Votes:
              1 Vote for this issue
              Watchers:
              3 Start watching this issue

              Dates

              • Created:
                Updated: