Project

General

Profile

Actions
Copy link

action #17478

closed

Missing step "partitioning" is making the test fail - The step "clock and time zone" is shown instead (was: test fails in partitioning)

Added by pgeorgiadis about 7 years ago. Updated about 7 years ago.

Status:
Resolved
Priority:
Normal
Assignee:
dzedro
Category:
Bugs in existing tests
Target version:
-
Start date:
2017-03-02
Due date:
% Done:

0%

Estimated time:
Difficulty:

Description

Observation

openQA test in scenario sle-12-SP1-Server-DVD-Incidents-ppc64le-qam-minimal@ppc64le fails in
partitioning

The past 3 tests are failing in maintenance a the same point. Seems like the 'partitioning' step of the Installation has not be recorded. There's no screenshot of it, and the video is not working for ppc64le. The logs are not helpful either. Probably what happens is that send_key $cmd{next}; is pressed twice or something like that. This cannot be a production bug because the installation comes from the GM iso and it was working 2 days ago for the last 3 months.

Reproducible

Fails since (at least) Build :128561.dbus-1.4134

Expected result

Last good: :128518.sane-backends.4257 (or more recent)

Problem

  • H1. a problem with the test
    • H1.1. the command send key is executed twice REJECTED by E1.1-1 and E1.1-2
  • H2. a problem of the send key command
    • H2.1. the command send key sends the key twice
  • H3. a problem of the product
  • H4 reproducible on x86_64
  • H5 reproducible always
  • H6 reproducible sporadic
  • H7 reproducible on ppc64le

Suggestions

  • E1.1-1 check if test code changed
    • results the code didn't changed
    • diff <(curl -s https://openqa.suse.de/tests/791622/modules/addon_products_sle/steps/1/src.txt) <(curl -s https://openqa.suse.de/tests/792564/modules/addon_products_sle/steps/1/src.txt)
    • diff <(curl -s https://openqa.suse.de/tests/791622/modules/partitioning/steps/1/src.txt) <(curl -s https://openqa.suse.de/tests/792564/modules/partitioning/steps/1/src.txt)
  • E1.1-2 if send_key is called twice in logfile
  • E4-1 clone the ppc64le failing job to execute it on x86_64 and check if the error happens.

Further details

Always latest result in this scenario: latest

Files

Download all files
Screenshot from 2017-03-02 18-59-16.png (64.2 KB) Screenshot from 2017-03-02 18-59-16.png pgeorgiadis, 2017-03-02 18:01
diff_last_passed_job_with_failing_job.png (217 KB) diff_last_passed_job_with_failing_job.png visual diff SLindoMansilla, 2017-03-03 10:28
Actions
Copy link
 #1

Updated by pgeorgiadis about 7 years ago

Just to make sure that this is an openQA bug and not an production bug, I downloaded the ISO and went through the installation.

Actions
Copy link
 #2

Updated by SLindoMansilla about 7 years ago

  • Description updated (diff)
Actions
Copy link
 #3

Updated by SLindoMansilla about 7 years ago

  • Description updated (diff)
Actions
Copy link
 #4

Updated by SLindoMansilla about 7 years ago

  • Subject changed from test fails in partitioning to Missing step "partitioning" is making the test fail - The step "clock and time zone" is shown instead (was: test fails in partitioning)
Actions
Copy link
 #5

Updated by SLindoMansilla about 7 years ago

Results of E1.1.-2

send_key is not called twice in logfile

Last passed job log:

17:23:55.5999 43965 ||| starting addon_products_sle tests/installation/addon_products_sle.pm at 2017-02-28 17:23:55
17:23:55.6002 Debug: /var/lib/openqa/share/tests/sle-12-SP1/tests/installation/addon_products_sle.pm:20 called testapi::assert_screen
17:23:55.6002 43965 <<< testapi::assert_screen(mustmatch=[
'inst-addon',
'addon-products'
], timeout=30)
17:23:56.0301 43969 MATCH(inst-addon-20141204:0.00)
17:23:56.0662 43969 MATCH(inst-addon-20161205:0.00)
17:23:56.1201 43969 MATCH(addon-products-20160121:0.06)
17:23:56.1523 43969 MATCH(addon-products-20161205:0.00)
17:23:56.2140 43969 MATCH(addon-products-20160505:0.06)
17:23:56.2143 43969 no match: 29.6s
17:23:57.0139 43969 MATCH(inst-addon-20141204:1.00)
17:23:57.0412 43969 MATCH(inst-addon-20161205:0.00)
17:23:57.0813 43969 MATCH(addon-products-20160121:0.06)
17:23:57.1016 43969 MATCH(addon-products-20161205:0.00)
17:23:57.1413 43969 MATCH(addon-products-20160505:0.06)
17:23:57.2703 43965 >>> testapi::_handle_found_needle: found inst-addon-20141204, similarity 1.00 @ 209/247
17:23:57.2705 Debug: /var/lib/openqa/share/tests/sle-12-SP1/tests/installation/addon_products_sle.pm:105 called testapi::send_key
17:23:57.2705 43965 <<< testapi::send_key(key='alt-n')
17:23:57.4720 Debug: /var/lib/openqa/share/tests/sle-12-SP1/tests/installation/addon_products_sle.pm:106 called testapi::wait_still_screen
17:23:57.4721 43965 <<< testapi::wait_still_screen(stilltime=5, timeout=30, simlvl=47)
17:24:03.5771 43965 >>> testapi::wait_still_screen: detected same image for 5 seconds
17:24:03.5775 43965 ||| finished addon_products_sle installation at 2017-02-28 17:24:03 (8 s)
17:24:03.5777 43965 ||| starting partitioning tests/installation/partitioning.pm at 2017-02-28 17:24:03

Failing Job log

17:23:27.3392 84915 ||| starting addon_products_sle tests/installation/addon_products_sle.pm at 2017-03-01 17:23:27
17:23:27.3395 Debug: /var/lib/openqa/share/tests/sle-12-SP1/tests/installation/addon_products_sle.pm:20 called testapi::assert_screen
17:23:27.3396 84915 <<< testapi::assert_screen(mustmatch=[
'inst-addon',
'addon-products'
], timeout=30)
17:23:27.5617 84931 MATCH(inst-addon-20141204:1.00)
17:23:27.5977 84931 MATCH(inst-addon-20161205:0.00)
17:23:27.6503 84931 MATCH(addon-products-20160121:0.06)
17:23:27.6820 84931 MATCH(addon-products-20161205:0.00)
17:23:27.7345 84931 MATCH(addon-products-20160505:0.06)
17:23:27.8633 84915 >>> testapi::_handle_found_needle: found inst-addon-20141204, similarity 1.00 @ 209/247
17:23:27.8634 Debug: /var/lib/openqa/share/tests/sle-12-SP1/tests/installation/addon_products_sle.pm:105 called testapi::send_key
17:23:27.8634 84915 <<< testapi::send_key(key='alt-n')
17:23:28.0667 Debug: /var/lib/openqa/share/tests/sle-12-SP1/tests/installation/addon_products_sle.pm:106 called testapi::wait_still_screen
17:23:28.0668 84915 <<< testapi::wait_still_screen(stilltime=5, timeout=30, simlvl=47)
17:23:34.1710 84915 >>> testapi::wait_still_screen: detected same image for 5 seconds
17:23:34.1713 84915 ||| finished addon_products_sle installation at 2017-03-01 17:23:34 (7 s)
17:23:34.1715 84915 ||| starting partitioning tests/installation/partitioning.pm at 2017-03-01 17:23:34
Actions
Copy link
 #6

Updated by SLindoMansilla about 7 years ago

  • Description updated (diff)
Actions
Copy link
 #7

Updated by SLindoMansilla about 7 years ago

  • Description updated (diff)
Actions
Copy link
 #8

Updated by SLindoMansilla about 7 years ago

  • Description updated (diff)
Actions
Copy link
 #10

Updated by mimi_vx about 7 years ago

i think this is due changes in lib/regristration.pm -- fix is probadly https://github.com/os-autoinst/os-autoinst-distri-opensuse/pull/2500

Actions
Copy link
 #11

Updated by SLindoMansilla about 7 years ago

The error is gone: https://openqa.suse.de/tests/806750

Probably because of the changes by mimi_vx.

Actions
Copy link
 #12

Updated by okurz about 7 years ago

  • Status changed from New to Resolved
  • Assignee set to dzedro

The changes have been done by dzedro (see PR) but yes, looks done.

Actions
Copy link

Also available in: Atom PDF