Starting subtest: flip-vs-expired-vblank-interruptible
Starting dynamic subtest: A-eDP1
Dynamic subtest A-eDP1: SUCCESS (8.635s)
Starting dynamic subtest: B-eDP1
Dynamic subtest B-eDP1: SUCCESS (8.700s)
Starting dynamic subtest: C-eDP1
[93.615032] (kms_flip:2418) CRITICAL: Test assertion failure function run_test...
[93.615090] (kms_flip:2418) CRITICAL: Failed assertion: end - start < 500
[93.615124] (kms_flip:2418) CRITICAL: Last errno: 4, Interrupted system call
Dynamic subtest C-eDP1 failed.
**** DEBUG ****
[91.903260] (kms_flip:2418) igt_fb-DEBUG: igt_create_fb_with_bo_size(width=288...
[91.903272] (kms_flip:2418) drmtest-DEBUG: Test requirement passed: is_intel_d...
[91.903291] (kms_flip:2418) drmtest-DEBUG: Test requirement passed: is_intel_d...
[91.903373] (kms_flip:2418) igt_fb-DEBUG: igt_create_fb_with_bo_size(handle=1,...
[91.903376] (kms_flip:2418) ioctl_wrappers-DEBUG: Test requirement passed: igt...
[91.903804] (kms_flip:2418) igt_fb-DEBUG: igt_create_fb_with_bo_size(width=288...
...

Starting subtest: flip-vs-expired-vblank-interruptible
Starting dynamic subtest: A-eDP1
Dynamic subtest A-eDP1: SUCCESS (8.680s)
Starting dynamic subtest: B-eDP1
[93.714232] (kms_flip:2408) CRITICAL: Test assertion failure function run_test...
[93.714282] (kms_flip:2408) CRITICAL: Failed assertion: end - start < 500
[93.714318] (kms_flip:2408) CRITICAL: Last errno: 4, Interrupted system call
Dynamic subtest B-eDP1 failed.
**** DEBUG ****
[92.369276] (kms_flip:2408) DEBUG: Vblank took 4us
[92.380378] (kms_flip:2408) DEBUG: name = flip
last_ts = 93.929771
last_received_ts = 93.929451
last_seq = 327
current_ts = 93.940880
current_received_ts = 93.940559
current_seq = 328
...

Starting subtest: flip-vs-expired-vblank-interruptible
Starting dynamic subtest: A-HDMI-A3
Dynamic subtest A-HDMI-A3: SUCCESS (7.799s)
Starting dynamic subtest: B-HDMI-A3
[77.794061] (kms_flip:2070) CRITICAL: Test assertion failure function run_test...
[77.794131] (kms_flip:2070) CRITICAL: Failed assertion: end - start < 500
[77.794210] (kms_flip:2070) CRITICAL: Last errno: 4, Interrupted system call
Dynamic subtest B-HDMI-A3 failed.
**** DEBUG ****
[76.432215] (kms_flip:2070) igt_fb-DEBUG: igt_create_fb_with_bo_size(width=192...
[76.432251] (kms_flip:2070) drmtest-DEBUG: Test requirement passed: is_intel_d...
[76.432307] (kms_flip:2070) drmtest-DEBUG: Test requirement passed: is_intel_d...
[76.435324] (kms_flip:2070) igt_fb-DEBUG: igt_create_fb_with_bo_size(handle=1,...
[76.435327] (kms_flip:2070) ioctl_wrappers-DEBUG: Test requirement passed: igt...
[76.435407] (kms_flip:2070) igt_fb-DEBUG: igt_create_fb_with_bo_size(width=192...
[76.435415] (kms_flip:2070) drmtest-DEBUG: Test requirement passed: is_intel_d...
[76.435430] (kms_flip:2070) drmtest-DEBUG: Test requirement passed: is_intel_d...
...

Starting subtest: flip-vs-expired-vblank-interruptible
Starting dynamic subtest: A-HDMI-A3
Dynamic subtest A-HDMI-A3: SUCCESS (7.795s)
Starting dynamic subtest: B-HDMI-A3
Dynamic subtest B-HDMI-A3: SUCCESS (7.681s)
Starting dynamic subtest: C-HDMI-A3
Dynamic subtest C-HDMI-A3: SUCCESS (7.681s)
Starting dynamic subtest: D-HDMI-A3
[132.543233] (kms_flip:2090) CRITICAL: Test assertion failure function run_tes...
[132.543325] (kms_flip:2090) CRITICAL: Failed assertion: end - start < 500
[132.543375] (kms_flip:2090) CRITICAL: Last errno: 4, Interrupted system call
Dynamic subtest D-HDMI-A3 failed.
**** DEBUG ****
[130.525623] (kms_flip:2090) DEBUG: Vblank took 56us
[130.542212] (kms_flip:2090) DEBUG: name = flip
last_ts = 130.513611
last_received_ts = 130.513260
...

Starting subtest: flip-vs-expired-vblank-interruptible
Starting dynamic subtest: A-HDMI-A3
Dynamic subtest A-HDMI-A3: SUCCESS (7.762s)
Starting dynamic subtest: B-HDMI-A3
Dynamic subtest B-HDMI-A3: SUCCESS (7.686s)
Starting dynamic subtest: C-HDMI-A3
Dynamic subtest C-HDMI-A3: SUCCESS (7.681s)
Starting dynamic subtest: D-HDMI-A3
[136.124032] (kms_flip:2091) CRITICAL: Test assertion failure function run_tes...
[136.124126] (kms_flip:2091) CRITICAL: Failed assertion: end - start < 500
[136.124200] (kms_flip:2091) CRITICAL: Last errno: 4, Interrupted system call
Dynamic subtest D-HDMI-A3 failed.
**** DEBUG ****
[135.041888] (kms_flip:2091) igt_fb-DEBUG: igt_create_fb_with_bo_size(width=19...
[135.041922] (kms_flip:2091) drmtest-DEBUG: Test requirement passed: is_intel_...
[135.041976] (kms_flip:2091) drmtest-DEBUG: Test requirement passed: is_intel_...
[135.042212] (kms_flip:2091) igt_fb-DEBUG: igt_create_fb_with_bo_size(handle=1...
...

Starting subtest: flip-vs-expired-vblank-interruptible
Starting dynamic subtest: A-HDMI-A2
[63.081133] (kms_flip:2121) CRITICAL: Test assertion failure function run_test...
[63.081199] (kms_flip:2121) CRITICAL: Failed assertion: end - start < 500
[63.081247] (kms_flip:2121) CRITICAL: Last errno: 4, Interrupted system call
Dynamic subtest A-HDMI-A2 failed.
**** DEBUG ****
[61.836895] (kms_flip:2121) igt_fb-DEBUG: igt_create_fb_with_bo_size(width=192...
[61.836905] (kms_flip:2121) drmtest-DEBUG: Test requirement passed: is_intel_d...
[61.836913] (kms_flip:2121) drmtest-DEBUG: Test requirement passed: is_intel_d...
[61.836974] (kms_flip:2121) igt_fb-DEBUG: igt_create_fb_with_bo_size(handle=1,...
[61.836977] (kms_flip:2121) ioctl_wrappers-DEBUG: Test requirement passed: igt...
[61.837015] (kms_flip:2121) igt_fb-DEBUG: igt_create_fb_with_bo_size(width=192...
[61.837021] (kms_flip:2121) drmtest-DEBUG: Test requirement passed: is_intel_d...
[61.837028] (kms_flip:2121) drmtest-DEBUG: Test requirement passed: is_intel_d...
[61.837071] (kms_flip:2121) igt_fb-DEBUG: igt_create_fb_with_bo_size(handle=2,...
[61.837072] (kms_flip:2121) ioctl_wrappers-DEBUG: Test requirement passed: igt...
...

Starting subtest: flip-vs-expired-vblank-interruptible
Starting dynamic subtest: A-HDMI-A2
[65.984389] (kms_flip:2123) CRITICAL: Test assertion failure function run_test...
[65.984450] (kms_flip:2123) CRITICAL: Failed assertion: end - start < 500
[65.984493] (kms_flip:2123) CRITICAL: Last errno: 4, Interrupted system call
Dynamic subtest A-HDMI-A2 failed.
**** DEBUG ****
[63.687841] (kms_flip:2123) DEBUG: Vblank took 33us
[63.706696] (kms_flip:2123) DEBUG: name = flip
last_ts = 63.473347
last_received_ts = 63.472786
last_seq = 546
current_ts = 63.492233
current_received_ts = 63.491646
current_seq = 547
count = 79
seq_step = 1
...

Starting subtest: flip-vs-expired-vblank-interruptible
Starting dynamic subtest: A-HDMI-A1
Dynamic subtest A-HDMI-A1: SUCCESS (10.188s)
Starting dynamic subtest: B-HDMI-A1
Dynamic subtest B-HDMI-A1: SUCCESS (10.143s)
Starting dynamic subtest: C-HDMI-A1
[101.508492] (kms_flip:2158) CRITICAL: Test assertion failure function run_tes...
[101.508564] (kms_flip:2158) CRITICAL: Failed assertion: end - start < 500
[101.508627] (kms_flip:2158) CRITICAL: Last errno: 4, Interrupted system call
Dynamic subtest C-HDMI-A1 failed.
**** DEBUG ****
[99.212067] (kms_flip:2158) DEBUG: Vblank took 32us
[99.230772] (kms_flip:2158) DEBUG: name = flip
last_ts = 99.344551
last_received_ts = 99.344147
last_seq = 161
current_ts = 99.363518
...

Starting subtest: flip-vs-expired-vblank-interruptible
Starting dynamic subtest: A-HDMI-A1
[76.290202] (kms_flip:2140) CRITICAL: Test assertion failure function run_test...
[76.290274] (kms_flip:2140) CRITICAL: Failed assertion: end - start < 500
[76.290333] (kms_flip:2140) CRITICAL: Last errno: 4, Interrupted system call
Dynamic subtest A-HDMI-A1 failed.
**** DEBUG ****
[75.156958] (kms_flip:2140) igt_fb-DEBUG: igt_create_fb_with_bo_size(width=192...
[75.156968] (kms_flip:2140) drmtest-DEBUG: Test requirement passed: is_intel_d...
[75.156976] (kms_flip:2140) drmtest-DEBUG: Test requirement passed: is_intel_d...
[75.157039] (kms_flip:2140) igt_fb-DEBUG: igt_create_fb_with_bo_size(handle=1,...
[75.157042] (kms_flip:2140) ioctl_wrappers-DEBUG: Test requirement passed: igt...
[75.157077] (kms_flip:2140) igt_fb-DEBUG: igt_create_fb_with_bo_size(width=192...
[75.157083] (kms_flip:2140) drmtest-DEBUG: Test requirement passed: is_intel_d...
[75.157091] (kms_flip:2140) drmtest-DEBUG: Test requirement passed: is_intel_d...
[75.157135] (kms_flip:2140) igt_fb-DEBUG: igt_create_fb_with_bo_size(handle=2,...
[75.157137] (kms_flip:2140) ioctl_wrappers-DEBUG: Test requirement passed: igt...
...

Starting subtest: flip-vs-expired-vblank-interruptible
Starting dynamic subtest: A-HDMI-A1
[76.255420] (kms_flip:2045) CRITICAL: Test assertion failure function run_test...
[76.255561] (kms_flip:2045) CRITICAL: Failed assertion: end - start < 500
[76.255635] (kms_flip:2045) CRITICAL: Last errno: 4, Interrupted system call
Dynamic subtest A-HDMI-A1 failed.
**** DEBUG ****
[74.237711] (kms_flip:2045) DEBUG: Vblank took 54us
[74.254275] (kms_flip:2045) DEBUG: name = flip
last_ts = 74.335648
last_received_ts = 74.335266
last_seq = 806
current_ts = 74.352310
current_received_ts = 74.351898
current_seq = 807
count = 206
seq_step = 1
...

Starting subtest: flip-vs-expired-vblank-interruptible
Starting dynamic subtest: A-HDMI-A4
Dynamic subtest A-HDMI-A4: SUCCESS (7.963s)
Starting dynamic subtest: B-HDMI-A4
[81.598560] (kms_flip:2043) CRITICAL: Test assertion failure function run_test...
[81.598718] (kms_flip:2043) CRITICAL: Failed assertion: end - start < 500
[81.598814] (kms_flip:2043) CRITICAL: Last errno: 4, Interrupted system call
Dynamic subtest B-HDMI-A4 failed.
**** DEBUG ****
[79.580739] (kms_flip:2043) DEBUG: Vblank took 55us
[79.597273] (kms_flip:2043) DEBUG: name = flip
last_ts = 79.606613
last_received_ts = 79.606178
last_seq = 44
current_ts = 79.623207
current_received_ts = 79.622711
current_seq = 45
...

Starting subtest: flip-vs-expired-vblank-interruptible
Starting dynamic subtest: A-HDMI-A4
[110.146038] (kms_flip:2069) CRITICAL: Test assertion failure function run_tes...
[110.146339] (kms_flip:2069) CRITICAL: Failed assertion: end - start < 500
[110.146427] (kms_flip:2069) CRITICAL: Last errno: 4, Interrupted system call
Dynamic subtest A-HDMI-A4 failed.
**** DEBUG ****
[108.128010] (kms_flip:2069) DEBUG: Vblank took 53us
[108.144614] (kms_flip:2069) DEBUG: name = flip
last_ts = 107.998138
last_received_ts = 107.997711
last_seq = 2834
current_ts = 108.014809
current_received_ts = 108.014381
current_seq = 2835
count = 54
seq_step = 1
...

Starting subtest: flip-vs-expired-vblank-interruptible
Starting dynamic subtest: A-HDMI-A1
Dynamic subtest A-HDMI-A1: SUCCESS (7.656s)
Starting dynamic subtest: B-HDMI-A1
Dynamic subtest B-HDMI-A1: SUCCESS (7.640s)
Starting dynamic subtest: C-HDMI-A1
[332.094889] (kms_flip:2710) CRITICAL: Test assertion failure function run_tes...
[332.094971] (kms_flip:2710) CRITICAL: Failed assertion: end - start < 500
[332.095015] (kms_flip:2710) CRITICAL: Last errno: 4, Interrupted system call
Dynamic subtest C-HDMI-A1 failed.
**** DEBUG ****
[331.082709] (kms_flip:2710) DEBUG: Vblank took 21us
[331.091065] (kms_flip:2710) DEBUG: name = flip
last_ts = 331.875397
last_received_ts = 331.875031
last_seq = 1171
current_ts = 331.883759
...

Starting subtest: flip-vs-expired-vblank-interruptible
Starting dynamic subtest: A-HDMI-A1
[56.140603] (kms_flip:2060) CRITICAL: Test assertion failure function run_test...
[56.140660] (kms_flip:2060) CRITICAL: Failed assertion: end - start < 500
[56.140699] (kms_flip:2060) CRITICAL: Last errno: 4, Interrupted system call
Dynamic subtest A-HDMI-A1 failed.
**** DEBUG ****
[55.131547] (kms_flip:2060) DEBUG: Vblank took 24us
[55.139797] (kms_flip:2060) DEBUG: name = flip
last_ts = 55.159351
last_received_ts = 55.159046
last_seq = 1798
current_ts = 55.167625
current_received_ts = 55.167278
current_seq = 1799
count = 555
seq_step = 1
...

Starting subtest: flip-vs-expired-vblank-interruptible
Starting dynamic subtest: A-HDMI-A1
Dynamic subtest A-HDMI-A1: SUCCESS (7.686s)
Starting dynamic subtest: B-HDMI-A1
Dynamic subtest B-HDMI-A1: SUCCESS (7.661s)
Starting dynamic subtest: C-HDMI-A1
Dynamic subtest C-HDMI-A1: SUCCESS (7.650s)
Starting dynamic subtest: D-HDMI-A1
[100.525066] (kms_flip:2091) CRITICAL: Test assertion failure function run_tes...
[100.525110] (kms_flip:2091) CRITICAL: Failed assertion: end - start < 500
[100.525137] (kms_flip:2091) CRITICAL: Last errno: 4, Interrupted system call
Dynamic subtest D-HDMI-A1 failed.
**** DEBUG ****
[99.516140] (kms_flip:2091) DEBUG: Vblank took 27us
[99.524569] (kms_flip:2091) DEBUG: name = flip
last_ts = 99.290565
last_received_ts = 99.290237
...

Starting subtest: flip-vs-expired-vblank-interruptible
Starting dynamic subtest: A-HDMI-A1
[95.597039] (kms_flip:2285) CRITICAL: Test assertion failure function run_test...
[95.597160] (kms_flip:2285) CRITICAL: Failed assertion: end - start < 500
[95.597420] (kms_flip:2285) CRITICAL: Last errno: 4, Interrupted system call
Dynamic subtest A-HDMI-A1 failed.
**** DEBUG ****
[93.579592] (kms_flip:2285) DEBUG: Vblank took 21us
[93.595759] (kms_flip:2285) DEBUG: name = flip
last_ts = 93.761383
last_received_ts = 93.761406
last_seq = 758
current_ts = 93.778046
current_received_ts = 93.777611
current_seq = 759
count = 70
seq_step = 1
...

Starting subtest: flip-vs-expired-vblank-interruptible
Starting dynamic subtest: A-HDMI-A1
Dynamic subtest A-HDMI-A1: SUCCESS (5.680s)
Starting dynamic subtest: B-HDMI-A1
[180.145267] (kms_flip:2322) CRITICAL: Test assertion failure function run_tes...
[180.145384] (kms_flip:2322) CRITICAL: Failed assertion: end - start < 500
[180.145469] (kms_flip:2322) CRITICAL: Last errno: 4, Interrupted system call
Dynamic subtest B-HDMI-A1 failed.
**** DEBUG ****
[179.323384] (kms_flip:2322) igt_fb-DEBUG: igt_create_fb_with_bo_size(width=19...
[179.323436] (kms_flip:2322) drmtest-DEBUG: Test requirement passed: is_intel_...
[179.323490] (kms_flip:2322) drmtest-DEBUG: Test requirement passed: is_intel_...
[179.323723] (kms_flip:2322) igt_fb-DEBUG: igt_create_fb_with_bo_size(handle=1...
[179.323735] (kms_flip:2322) ioctl_wrappers-DEBUG: Test requirement passed: ig...
[179.323845] (kms_flip:2322) igt_fb-DEBUG: igt_create_fb_with_bo_size(width=19...
[179.323882] (kms_flip:2322) drmtest-DEBUG: Test requirement passed: is_intel_...
[179.323936] (kms_flip:2322) drmtest-DEBUG: Test requirement passed: is_intel_...
...

Starting subtest: flip-vs-expired-vblank-interruptible
Starting dynamic subtest: A-HDMI-A1
Dynamic subtest A-HDMI-A1: SUCCESS (5.671s)
Starting dynamic subtest: B-HDMI-A1
[162.682013] (kms_flip:2285) CRITICAL: Test assertion failure function run_tes...
[162.682164] (kms_flip:2285) CRITICAL: Failed assertion: end - start < 500
[162.682260] (kms_flip:2285) CRITICAL: Last errno: 4, Interrupted system call
Dynamic subtest B-HDMI-A1 failed.
**** DEBUG ****
[161.376259] (kms_flip:2285) igt_fb-DEBUG: igt_create_fb_with_bo_size(width=19...
[161.376315] (kms_flip:2285) drmtest-DEBUG: Test requirement passed: is_intel_...
[161.376371] (kms_flip:2285) drmtest-DEBUG: Test requirement passed: is_intel_...
[161.376609] (kms_flip:2285) igt_fb-DEBUG: igt_create_fb_with_bo_size(handle=1...
[161.376621] (kms_flip:2285) ioctl_wrappers-DEBUG: Test requirement passed: ig...
[161.378853] (kms_flip:2285) igt_fb-DEBUG: igt_create_fb_with_bo_size(width=19...
[161.378894] (kms_flip:2285) drmtest-DEBUG: Test requirement passed: is_intel_...
[161.378954] (kms_flip:2285) drmtest-DEBUG: Test requirement passed: is_intel_...
...

Starting subtest: flip-vs-expired-vblank-interruptible
Starting dynamic subtest: A-HDMI-A1
Dynamic subtest A-HDMI-A1: SUCCESS (5.691s)
Starting dynamic subtest: B-HDMI-A1
Dynamic subtest B-HDMI-A1: SUCCESS (5.434s)
Starting dynamic subtest: C-HDMI-A1
Dynamic subtest C-HDMI-A1: SUCCESS (5.425s)
Starting dynamic subtest: A-HDMI-A2
Dynamic subtest A-HDMI-A2: SUCCESS (5.429s)
Starting dynamic subtest: B-HDMI-A2
[177.953486] (kms_flip:2284) CRITICAL: Test assertion failure function run_tes...
[177.953680] (kms_flip:2284) CRITICAL: Failed assertion: end - start < 500
[177.953778] (kms_flip:2284) CRITICAL: Last errno: 4, Interrupted system call
Dynamic subtest B-HDMI-A2 failed.
**** DEBUG ****
[175.936100] (kms_flip:2284) DEBUG: Vblank took 24us
[175.952629] (kms_flip:2284) DEBUG: name = flip
...

Starting subtest: flip-vs-expired-vblank-interruptible
Starting dynamic subtest: A-VGA1
Dynamic subtest A-VGA1: SUCCESS (7.804s)
Starting dynamic subtest: B-VGA1
Dynamic subtest B-VGA1: SUCCESS (7.708s)
Starting dynamic subtest: A-HDMI-A1
Dynamic subtest A-HDMI-A1: SUCCESS (7.772s)
Starting dynamic subtest: B-HDMI-A1
[127.482767] (kms_flip:2450) CRITICAL: Test assertion failure function run_tes...
[127.482822] (kms_flip:2450) CRITICAL: Failed assertion: end - start < 500
[127.482895] (kms_flip:2450) CRITICAL: Last errno: 4, Interrupted system call
Dynamic subtest B-HDMI-A1 failed.
**** DEBUG ****
[125.469582] (kms_flip:2450) DEBUG: Vblank took 8us
[125.486204] (kms_flip:2450) DEBUG: name = flip
last_ts = 125.510719
last_received_ts = 125.510201
...