Autopilot run with -v prints debug information

Bug #1420949 reported by Leo Arias
16
This bug affects 2 people
Affects Status Importance Assigned to Milestone
Autopilot
Fix Released
Undecided
Canonical Platform QA Team
autopilot (Ubuntu)
Vivid
Fix Released
Undecided
Unassigned

Bug Description

The -v option in autopilot run should print logged messages, but not too many. Currently, with -v everything in debug is printed, which is too much. For example, when making a finger move, we get:

[...]
19:54:21.865 DEBUG _uinput:414 - Moving pointing 'finger' to position 270,116.
19:54:21.866 DEBUG _uinput:419 - The pointing 'finger' is now at position 270,116.
19:54:21.878 DEBUG _uinput:414 - Moving pointing 'finger' to position 270,110.
19:54:21.880 DEBUG _uinput:419 - The pointing 'finger' is now at position 270,110.
19:54:21.891 DEBUG _uinput:414 - Moving pointing 'finger' to position 270,104.
19:54:21.893 DEBUG _uinput:419 - The pointing 'finger' is now at position 270,104.
[...]

That's one line per pixel.

I think that -v should only print the info logging level. That way the test writer decides what goes into the -v log, and we can use it to put information about the high level user actions that the test executes, like "drag from the bottom", instead of the many finger moves.
Then, -vv should be the current -v, printing also the debug level in case we need extra information.
And we can add a -vvv to be the new -vv.

[Impact]

 * Current logging levels are incorrect and cause a huge amount of un-needed details to be output during normal runs.

 * justification: Streamlines seeing issues in test run logs

 * This fix improves the quality of the logging output which is essential for debugging test failures.

[Test Case]

 * To reproduce this bug:
    - Install the current python3-autopilot (apt-get install python3-autopilot)
    - run this test (using the following command):
      $ python3 -m autopilot.run run -v autopilot.tests.functional.test_input_stack.InputStackKeyboardTypingTests.test_text_typing

    - Observe the abundance of messages similar to:
04:47:46.152 DEBUG _X11:237 - Sending release event for key: '
04:47:46.188 DEBUG _X11:234 - Sending press event for key: <

    - With the fixed release there will be no DEBUG level messages.

[Regression Potential]

 * That the logging output is different than expected

Changed in autopilot:
status: New → In Progress
status: In Progress → Fix Committed
assignee: nobody → Canonical Platform QA Team (canonical-platform-qa)
description: updated
Revision history for this message
Steve Langasek (vorlon) wrote : Please test proposed package

Hello Leo, or anyone else affected,

Accepted autopilot into vivid-proposed. The package will build now and be available at https://launchpad.net/ubuntu/+source/autopilot/1.5.1+15.04.20150522-0ubuntu1 in a few hours, and then in the -proposed repository.

Please help us by testing this new package. See https://wiki.ubuntu.com/Testing/EnableProposed for documentation how to enable and use -proposed. Your feedback will aid us getting this update out to other Ubuntu users.

If this package fixes the bug for you, please add a comment to this bug, mentioning the version of the package you tested, and change the tag from verification-needed to verification-done. If it does not fix the bug for you, please add a comment stating that, and change the tag to verification-failed. In either case, details of your testing will help us make a better decision.

Further information regarding the verification process can be found at https://wiki.ubuntu.com/QATeam/PerformingSRUVerification . Thank you in advance!

Changed in autopilot (Ubuntu Vivid):
status: New → Fix Committed
tags: added: verification-needed
tags: added: verification-done
removed: verification-needed
Revision history for this message
Chris J Arges (arges) wrote : Update Released

The verification of the Stable Release Update for autopilot has completed successfully and the package has now been released to -updates. Subsequently, the Ubuntu Stable Release Updates Team is being unsubscribed and will not receive messages about this bug report. In the event that you encounter a regression using the package from -updates please report a new bug using ubuntu-bug and tag the bug report regression-update so we can easily find any regressions.

Revision history for this message
Launchpad Janitor (janitor) wrote :

This bug was fixed in the package autopilot - 1.5.1+15.04.20150522-0ubuntu1

---------------
autopilot (1.5.1+15.04.20150522-0ubuntu1) vivid; urgency=medium

  [ CI Train Bot ]
  * New rebuild forced.

  [ Christopher Lee, Federico Gimenez, Leo Arias, Richard Huddie, Vincent Ladeuil ]
  * Bug fixes for logging (debug level now -vv) and application of CPO
    bases for proxy objects. (LP: #1425721, #1376996, #1420949)

 -- CI Train Bot <email address hidden> Fri, 22 May 2015 16:54:03 +0000

Changed in autopilot (Ubuntu Vivid):
status: Fix Committed → Fix Released
Changed in autopilot:
status: Fix Committed → Fix Released
To post a comment you must log in.
This report contains Public information  
Everyone can see this information.

Duplicates of this bug

Other bug subscribers

Remote bug watches

Bug watches keep track of this bug in other bug trackers.