[47.621473] Initializing watchdogs
[47.621623]   /dev/watchdog0
[47.630867] [001/171] (960s left) i915_module_load (load)
[47.744932] Starting subtest: load
[49.673806] Subtest load: SUCCESS (1.925s)
[49.713827] [002/171] (958s left) core_auth (basic-auth)
[50.025722] Starting subtest: basic-auth
[50.032059] Subtest basic-auth: SUCCESS (0.001s)
[50.104107] [003/171] (958s left) debugfs_test (read_all_entries)
[50.220899] Starting subtest: read_all_entries
[50.286813] Subtest read_all_entries: SUCCESS (0.065s)
[51.088638] [004/171] (957s left) debugfs_test (basic-hwmon)
[51.204397] Starting subtest: basic-hwmon
[51.207554] Subtest basic-hwmon: SKIP (0.000s)
[51.787027] [005/171] (956s left) fbdev (eof)
[51.914742] Starting subtest: eof
[51.916388] Subtest eof: SUCCESS (0.000s)
[51.972117] [006/171] (956s left) fbdev (info)
[52.078117] Starting subtest: info
[52.079964] Subtest info: SUCCESS (0.000s)
[52.139313] [007/171] (956s left) fbdev (nullptr)
[52.247414] Starting subtest: nullptr
[52.249195] Subtest nullptr: SUCCESS (0.000s)
[52.306891] [008/171] (955s left) fbdev (read)
[52.413769] Starting subtest: read
[52.623244] Subtest read: SUCCESS (0.209s)
[52.672937] [009/171] (955s left) fbdev (write)
[52.779515] Starting subtest: write
[52.881451] Subtest write: SUCCESS (0.101s)
[52.936738] [010/171] (955s left) gem_basic (bad-close)
[53.046023] Starting subtest: bad-close
[53.049199] Subtest bad-close: SUCCESS (0.000s)
[53.119585] [011/171] (955s left) gem_basic (create-close)
[53.228455] Starting subtest: create-close
[53.231649] Subtest create-close: SUCCESS (0.000s)
[53.302195] [012/171] (955s left) gem_basic (create-fd-close)
[53.411424] Starting subtest: create-fd-close
[53.414570] Subtest create-fd-close: SUCCESS (0.000s)
[53.484327] [013/171] (954s left) gem_busy (busy@all-engines)
[53.620270] Starting subtest: busy
[53.625572] Starting dynamic subtest: all-engines
[53.654693] Dynamic subtest all-engines: SUCCESS (0.034s)
[53.656388] Subtest busy: SUCCESS (0.034s)
[53.968110] [014/171] (954s left) gem_close_race (basic-process)
[54.111718] Starting subtest: basic-process
[54.155172] Subtest basic-process: SUCCESS (0.046s)
[54.335374] [015/171] (954s left) gem_close_race (basic-threads)
[54.456149] Starting subtest: basic-threads
[55.587834] Subtest basic-threads: SUCCESS (1.132s)
[55.765768] [016/171] (952s left) gem_ctx_create (basic)
[55.885864] Starting subtest: basic
[55.887778] Subtest basic: SUCCESS (0.001s)
[56.064775] [017/171] (952s left) gem_ctx_create (basic-files)
[56.185243] Starting subtest: basic-files
[58.203523] Subtest basic-files: SUCCESS (2.018s)
[58.423397] [018/171] (950s left) gem_ctx_exec (basic)
[58.541345] Starting subtest: basic
[58.542987] Subtest basic: SUCCESS (0.001s)
[58.595428] [019/171] (949s left) gem_exec_basic (basic)
[58.714796] Starting subtest: basic
[58.716640] Starting dynamic subtest: rcs0-smem
[58.718493] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[58.726397] Starting dynamic subtest: vcs0-smem
[58.728445] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[58.730497] Subtest basic: SUCCESS (0.002s)
[58.891993] [020/171] (949s left) gem_exec_create (basic)
[59.006983] Starting subtest: basic
[59.009095] Starting dynamic subtest: smem
[61.035398] Dynamic subtest smem: SUCCESS (2.028s)
[61.037348] Subtest basic: SUCCESS (2.028s)
[61.418306] [021/171] (947s left) gem_exec_fence (basic-busy)
[61.657744] Starting subtest: basic-busy
[61.659657] Starting dynamic subtest: rcs0
[61.669199] Dynamic subtest rcs0: SUCCESS (0.014s)
[61.677886] Starting dynamic subtest: vcs0
[61.683688] Dynamic subtest vcs0: SUCCESS (0.014s)
[61.685612] Subtest basic-busy: SUCCESS (0.028s)
[62.169635] [022/171] (946s left) gem_exec_fence (basic-wait)
[62.411317] Starting subtest: basic-wait
[62.412967] Starting dynamic subtest: rcs0
[62.420930] Dynamic subtest rcs0: SUCCESS (0.010s)
[62.429662] Starting dynamic subtest: vcs0
[62.433529] Dynamic subtest vcs0: SUCCESS (0.012s)
[62.435469] Subtest basic-wait: SUCCESS (0.022s)
[62.870338] [023/171] (945s left) gem_exec_fence (basic-await)
[63.103416] Starting subtest: basic-await
[63.106697] Starting dynamic subtest: rcs0
[63.173673] Dynamic subtest rcs0: SUCCESS (0.070s)
[63.182123] Starting dynamic subtest: vcs0
[63.239546] Dynamic subtest vcs0: SUCCESS (0.066s)
[63.241714] Subtest basic-await: SUCCESS (0.136s)
[63.683029] [024/171] (944s left) gem_exec_fence (nb-await)
[63.919720] Starting subtest: nb-await
[63.922120] Starting dynamic subtest: rcs0
[63.972977] Dynamic subtest rcs0: SUCCESS (0.054s)
[63.981662] Starting dynamic subtest: vcs0
[64.026809] Dynamic subtest vcs0: SUCCESS (0.053s)
[64.028889] Subtest nb-await: SUCCESS (0.108s)
[64.464663] [025/171] (944s left) gem_exec_gttfill (basic)
[64.581343] Starting subtest: basic
[71.985072] Subtest basic: SUCCESS (7.404s)
[72.214955] [026/171] (936s left) gem_exec_parallel (engines)
[72.420361] Starting subtest: engines
[72.423784] Starting dynamic subtest: basic
[74.137235] Dynamic subtest basic: SUCCESS (1.717s)
[74.146455] Starting dynamic subtest: contexts
[76.089341] Dynamic subtest contexts: SUCCESS (1.950s)
[76.098349] Starting dynamic subtest: fds
[76.122257] Dynamic subtest fds: SKIP (0.000s)
[76.131314] Starting dynamic subtest: userptr
[77.902116] Dynamic subtest userptr: SUCCESS (1.778s)
[77.928032] Subtest engines: SUCCESS (5.446s)
[78.106717] [027/171] (930s left) gem_exec_store (basic)
[78.283076] Starting subtest: basic
[78.311392] Subtest basic: SUCCESS (0.028s)
[78.487704] [028/171] (930s left) gem_flink_basic (bad-flink)
[78.596599] Starting subtest: bad-flink
[78.598325] Subtest bad-flink: SUCCESS (0.000s)
[78.670226] [029/171] (930s left) gem_flink_basic (bad-open)
[78.775892] Starting subtest: bad-open
[78.777671] Subtest bad-open: SUCCESS (0.000s)
[78.839048] [030/171] (929s left) gem_flink_basic (basic)
[78.947110] Starting subtest: basic
[78.948800] Subtest basic: SUCCESS (0.000s)
[79.020070] [031/171] (929s left) gem_flink_basic (double-flink)
[79.127050] Starting subtest: double-flink
[79.128678] Subtest double-flink: SUCCESS (0.000s)
[79.201055] [032/171] (929s left) gem_flink_basic (flink-lifetime)
[79.305411] Starting subtest: flink-lifetime
[79.307511] Subtest flink-lifetime: SUCCESS (0.001s)
[79.385345] [033/171] (929s left) gem_huc_copy (huc-copy)
[79.500399] Subtest huc-copy: SKIP (0.000s)
[79.523733] [034/171] (929s left) gem_linear_blits (basic)
[79.734443] Starting subtest: basic
[79.748242] Subtest basic: SUCCESS (0.012s)
[79.867686] [035/171] (929s left) gem_mmap (basic)
[80.068757] Starting subtest: basic
[80.077822] Subtest basic: SUCCESS (0.001s)
[80.151351] [036/171] (928s left) gem_mmap_gtt (basic)
[80.259017] Starting subtest: basic
[80.260637] Subtest basic: SUCCESS (0.001s)
[80.319171] [037/171] (928s left) gem_render_linear_blits (basic)
[80.430089] Starting subtest: basic
[80.464932] Subtest basic: SUCCESS (0.039s)
[80.521639] [038/171] (928s left) gem_render_tiled_blits (basic)
[80.631930] Starting subtest: basic
[80.670132] Subtest basic: SUCCESS (0.036s)
[80.701683] [039/171] (928s left) gem_ringfill (basic-all)
[80.861554] Starting subtest: basic-all
[81.979400] Subtest basic-all: SUCCESS (1.120s)
[82.047076] [040/171] (926s left) gem_softpin (allocator-basic)
[82.158520] Subtest allocator-basic: SKIP (0.000s)
[82.229656] [041/171] (926s left) gem_softpin (allocator-basic-reserve)
[82.341382] Subtest allocator-basic-reserve: SKIP (0.000s)
[82.412475] [042/171] (926s left) gem_softpin (safe-alignment)
[82.522576] Starting subtest: safe-alignment
[82.524464] Subtest safe-alignment: SUCCESS (0.006s)
[82.594984] [043/171] (926s left) gem_sync (basic-all)
[82.711269] Starting subtest: basic-all
[84.901910] Subtest basic-all: SUCCESS (2.190s)
[85.091152] [044/171] (924s left) gem_sync (basic-each)
[85.213079] Starting subtest: basic-each
[87.342048] Subtest basic-each: SUCCESS (2.127s)
[87.518887] [045/171] (921s left) gem_tiled_blits (basic)
[87.752827] Starting subtest: basic
[87.776240] Subtest basic: SUCCESS (0.025s)
[87.888648] [046/171] (921s left) gem_tiled_fence_blits (basic)
[88.200149] Starting subtest: basic
[88.213399] Subtest basic: SUCCESS (0.011s)
[88.319027] [047/171] (920s left) gem_tiled_pread_basic
[88.750674] [048/171] (920s left) gem_wait (busy@all-engines)
[88.874071] Starting subtest: busy
[88.875890] Starting dynamic subtest: all-engines
[89.386865] Dynamic subtest all-engines: SUCCESS (0.512s)
[89.388510] Subtest busy: SUCCESS (0.513s)
[89.582260] [049/171] (919s left) gem_wait (wait@all-engines)
[89.708338] Starting subtest: wait
[89.710173] Starting dynamic subtest: all-engines
[90.719953] Dynamic subtest all-engines: SUCCESS (1.014s)
[90.721736] Subtest wait: SUCCESS (1.014s)
[90.927979] [050/171] (918s left) i915_getparams_basic (basic-eu-total)
[91.034828] Starting subtest: basic-eu-total
[91.038259] Subtest basic-eu-total: SUCCESS (0.000s)
[91.097065] [051/171] (918s left) i915_getparams_basic (basic-subslice-total)
[91.204087] Starting subtest: basic-subslice-total
[91.207350] Subtest basic-subslice-total: SUCCESS (0.000s)
[91.277528] [052/171] (917s left) i915_hangman (error-state-basic)
[91.390851] Starting subtest: error-state-basic
[91.396763] Subtest error-state-basic: SUCCESS (0.008s)
[91.431032] [053/171] (917s left) i915_pciid
[91.611098] [054/171] (917s left) kms_addfb_basic (addfb25-bad-modifier)
[92.248065] Starting subtest: addfb25-bad-modifier
[92.249689] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[93.306075] [055/171] (916s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[93.919229] Starting subtest: addfb25-framebuffer-vs-set-tiling
[93.921268] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[94.752860] [056/171] (914s left) kms_addfb_basic (addfb25-modifier-no-flag)
[95.375317] Starting subtest: addfb25-modifier-no-flag
[95.376954] Subtest addfb25-modifier-no-flag: SUCCESS (0.001s)
[96.216530] [057/171] (913s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[96.828782] Starting subtest: addfb25-x-tiled-legacy
[96.830541] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[97.680048] [058/171] (911s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[98.298336] Starting subtest: addfb25-x-tiled-mismatch-legacy
[98.299970] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[99.143837] [059/171] (910s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[100.146959] Starting subtest: addfb25-yf-tiled-legacy
[100.149236] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[100.624248] [060/171] (908s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[101.614496] Starting subtest: addfb25-y-tiled-legacy
[101.616274] Subtest addfb25-y-tiled-legacy: SUCCESS (0.001s)
[102.087897] [061/171] (907s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[103.077711] Starting subtest: addfb25-y-tiled-small-legacy
[103.081120] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[103.717900] [062/171] (905s left) kms_addfb_basic (bad-pitch-0)
[103.846529] Starting subtest: bad-pitch-0
[103.848376] Subtest bad-pitch-0: SUCCESS (0.000s)
[105.147979] [063/171] (904s left) kms_addfb_basic (bad-pitch-1024)
[105.255121] Starting subtest: bad-pitch-1024
[105.256759] Subtest bad-pitch-1024: SUCCESS (0.000s)
[106.595602] [064/171] (902s left) kms_addfb_basic (bad-pitch-128)
[106.701884] Starting subtest: bad-pitch-128
[106.703693] Subtest bad-pitch-128: SUCCESS (0.000s)
[108.043446] [065/171] (901s left) kms_addfb_basic (bad-pitch-256)
[108.154839] Starting subtest: bad-pitch-256
[108.156542] Subtest bad-pitch-256: SUCCESS (0.000s)
[109.506598] [066/171] (900s left) kms_addfb_basic (bad-pitch-32)
[109.612463] Starting subtest: bad-pitch-32
[109.614295] Subtest bad-pitch-32: SUCCESS (0.000s)
[110.993719] [067/171] (898s left) kms_addfb_basic (bad-pitch-63)
[111.100679] Starting subtest: bad-pitch-63
[111.102476] Subtest bad-pitch-63: SUCCESS (0.000s)
[112.467236] [068/171] (897s left) kms_addfb_basic (bad-pitch-65536)
[112.573140] Starting subtest: bad-pitch-65536
[112.574929] Subtest bad-pitch-65536: SUCCESS (0.000s)
[114.174282] [069/171] (895s left) kms_addfb_basic (bad-pitch-999)
[114.387762] Starting subtest: bad-pitch-999
[114.389538] Subtest bad-pitch-999: SUCCESS (0.000s)
[115.760161] [070/171] (893s left) kms_addfb_basic (basic)
[115.867101] Starting subtest: basic
[115.868819] Subtest basic: SUCCESS (0.000s)
[117.241850] [071/171] (892s left) kms_addfb_basic (basic-x-tiled-legacy)
[118.651065] Starting subtest: basic-x-tiled-legacy
[118.652827] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[118.738049] [072/171] (890s left) kms_addfb_basic (basic-y-tiled-legacy)
[120.121316] Starting subtest: basic-y-tiled-legacy
[120.123309] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[120.218189] [073/171] (889s left) kms_addfb_basic (bo-too-small)
[120.847056] Starting subtest: bo-too-small
[120.848689] Subtest bo-too-small: SUCCESS (0.000s)
[121.715795] [074/171] (888s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[122.343096] Starting subtest: bo-too-small-due-to-tiling
[122.344733] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[123.429476] [075/171] (886s left) kms_addfb_basic (clobberred-modifier)
[123.550613] Starting subtest: clobberred-modifier
[123.552287] Subtest clobberred-modifier: SUCCESS (0.000s)
[124.928412] [076/171] (884s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[126.350479] Starting subtest: framebuffer-vs-set-tiling
[126.352292] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[126.439506] [077/171] (883s left) kms_addfb_basic (invalid-get-prop)
[127.870256] Starting subtest: invalid-get-prop
[127.872065] Subtest invalid-get-prop: SUCCESS (0.000s)
[127.952862] [078/171] (881s left) kms_addfb_basic (invalid-get-prop-any)
[129.385289] Starting subtest: invalid-get-prop-any
[129.387107] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[129.482152] [079/171] (880s left) kms_addfb_basic (invalid-set-prop)
[130.898334] Starting subtest: invalid-set-prop
[130.900150] Subtest invalid-set-prop: SUCCESS (0.000s)
[130.995645] [080/171] (878s left) kms_addfb_basic (invalid-set-prop-any)
[132.410288] Starting subtest: invalid-set-prop-any
[132.412066] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[132.493786] [081/171] (877s left) kms_addfb_basic (no-handle)
[132.601684] Starting subtest: no-handle
[132.603384] Subtest no-handle: SUCCESS (0.000s)
[134.190339] [082/171] (875s left) kms_addfb_basic (size-max)
[134.834340] Starting subtest: size-max
[134.835971] Subtest size-max: SUCCESS (0.000s)
[135.720886] [083/171] (874s left) kms_addfb_basic (small-bo)
[136.352085] Starting subtest: small-bo
[136.353745] Subtest small-bo: SUCCESS (0.000s)
[137.239069] [084/171] (872s left) kms_addfb_basic (tile-pitch-mismatch)
[138.669485] Starting subtest: tile-pitch-mismatch
[138.671391] Subtest tile-pitch-mismatch: SUCCESS (0.001s)
[138.764314] [085/171] (871s left) kms_addfb_basic (too-high)
[139.407894] Starting subtest: too-high
[139.409781] Subtest too-high: SUCCESS (0.002s)
[140.310591] [086/171] (869s left) kms_addfb_basic (too-wide)
[140.946467] Starting subtest: too-wide
[140.948571] Subtest too-wide: SUCCESS (0.000s)
[141.837634] [087/171] (868s left) kms_addfb_basic (unused-handle)
[142.039879] Starting subtest: unused-handle
[142.062485] Subtest unused-handle: SUCCESS (0.000s)
[143.572856] [088/171] (866s left) kms_addfb_basic (unused-modifier)
[143.681835] Starting subtest: unused-modifier
[143.683525] Subtest unused-modifier: SUCCESS (0.000s)
[145.301659] [089/171] (865s left) kms_addfb_basic (unused-offsets)
[145.411371] Starting subtest: unused-offsets
[145.413145] Subtest unused-offsets: SUCCESS (0.000s)
[146.833066] [090/171] (863s left) kms_addfb_basic (unused-pitches)
[146.942182] Starting subtest: unused-pitches
[146.943871] Subtest unused-pitches: SUCCESS (0.000s)
[148.362296] [091/171] (862s left) kms_busy (basic)
[149.018995] Starting subtest: basic
[149.020842] Starting dynamic subtest: flip
[149.729418] Dynamic subtest flip: SUCCESS (0.705s)
[149.744667] Starting dynamic subtest: modeset
[150.522803] Dynamic subtest modeset: SUCCESS (0.795s)
[150.524740] Subtest basic: SUCCESS (1.503s)
[150.703803] [092/171] (859s left) kms_chamelium_hpd (dp-hpd-fast)
[151.466457] Subtest dp-hpd-fast: SKIP (0.000s)
[151.607326] [093/171] (858s left) kms_chamelium_edid (dp-edid-read)
[152.382278] Subtest dp-edid-read: SKIP (0.000s)
[152.520702] [094/171] (857s left) kms_chamelium_frames (dp-crc-fast)
[153.259433] Subtest dp-crc-fast: SKIP (0.000s)
[153.402508] [095/171] (857s left) kms_chamelium_hpd (hdmi-hpd-fast)
[154.177225] Subtest hdmi-hpd-fast: SKIP (0.000s)
[154.534380] [096/171] (855s left) kms_chamelium_edid (hdmi-edid-read)
[155.293656] Subtest hdmi-edid-read: SKIP (0.000s)
[155.435692] [097/171] (855s left) kms_chamelium_frames (hdmi-crc-fast)
[156.205854] Subtest hdmi-crc-fast: SKIP (0.000s)
[156.351619] [098/171] (854s left) kms_chamelium_hpd (vga-hpd-fast)
[157.105808] Subtest vga-hpd-fast: SKIP (0.000s)
[157.250776] [099/171] (853s left) kms_chamelium_edid (vga-edid-read)
[158.006818] Subtest vga-edid-read: SKIP (0.000s)
[158.159790] [100/171] (852s left) kms_prop_blob (basic)
[158.274436] Starting subtest: basic
[158.276255] Subtest basic: SUCCESS (0.000s)
[158.350672] [101/171] (852s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[159.017114] Starting subtest: basic-busy-flip-before-cursor-atomic
[160.072346] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (1.056s)
[160.243268] [102/171] (850s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[160.912179] Starting subtest: basic-busy-flip-before-cursor-legacy
[161.956489] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.050s)
[162.137861] [103/171] (848s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[162.785612] Starting subtest: basic-flip-after-cursor-atomic
[163.840296] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.054s)
[164.012328] [104/171] (846s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[164.670683] Starting subtest: basic-flip-after-cursor-legacy
[165.699257] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.027s)
[166.081508] [105/171] (844s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[166.761657] Starting subtest: basic-flip-after-cursor-varying-size
[167.817967] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.057s)
[167.991642] [106/171] (842s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[168.661033] Starting subtest: basic-flip-before-cursor-atomic
[169.743669] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.086s)
[169.918682] [107/171] (840s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[170.577031] Starting subtest: basic-flip-before-cursor-legacy
[171.624371] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.056s)
[171.795096] [108/171] (838s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[172.453616] Starting subtest: basic-flip-before-cursor-varying-size
[173.532088] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.077s)
[173.704680] [109/171] (837s left) kms_flip (basic-flip-vs-dpms)
[174.201220] Starting subtest: basic-flip-vs-dpms
[174.202825] Starting dynamic subtest: A-VGA1
[175.008833] Dynamic subtest A-VGA1: SUCCESS (0.807s)
[175.023500] Starting dynamic subtest: B-VGA1
[175.728868] Dynamic subtest B-VGA1: SUCCESS (0.719s)
[175.750495] Starting dynamic subtest: A-HDMI-A1
[176.487267] Dynamic subtest A-HDMI-A1: SUCCESS (0.755s)
[176.502223] Starting dynamic subtest: B-HDMI-A1
[177.252561] Dynamic subtest B-HDMI-A1: SUCCESS (0.766s)
[177.254262] Subtest basic-flip-vs-dpms: SUCCESS (3.059s)
[177.838311] [110/171] (832s left) kms_flip (basic-flip-vs-modeset)
[178.342192] Starting subtest: basic-flip-vs-modeset
[178.343825] Starting dynamic subtest: A-VGA1
[179.167305] Dynamic subtest A-VGA1: SUCCESS (0.829s)
[179.183567] Starting dynamic subtest: B-VGA1
[179.829652] Dynamic subtest B-VGA1: SUCCESS (0.662s)
[179.845696] Starting dynamic subtest: A-HDMI-A1
[180.548898] Dynamic subtest A-HDMI-A1: SUCCESS (0.711s)
[180.559055] Starting dynamic subtest: B-HDMI-A1
[181.337797] Dynamic subtest B-HDMI-A1: SUCCESS (0.796s)
[181.339478] Subtest basic-flip-vs-modeset: SUCCESS (3.004s)
[181.492272] [111/171] (829s left) kms_flip (basic-flip-vs-wf_vblank)
[181.999131] Starting subtest: basic-flip-vs-wf_vblank
[182.000769] Starting dynamic subtest: A-VGA1
[183.084166] Dynamic subtest A-VGA1: SUCCESS (1.092s)
[183.103079] Starting dynamic subtest: B-VGA1
[184.080218] Dynamic subtest B-VGA1: SUCCESS (0.990s)
[184.097677] Starting dynamic subtest: A-HDMI-A1
[185.303046] Dynamic subtest A-HDMI-A1: SUCCESS (1.207s)
[185.326985] Starting dynamic subtest: B-HDMI-A1
[186.573434] Dynamic subtest B-HDMI-A1: SUCCESS (1.256s)
[186.579291] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.575s)
[186.840449] [112/171] (824s left) kms_flip (basic-plain-flip)
[187.339870] Starting subtest: basic-plain-flip
[187.341653] Starting dynamic subtest: A-VGA1
[188.145712] Dynamic subtest A-VGA1: SUCCESS (0.807s)
[188.162607] Starting dynamic subtest: B-VGA1
[188.866320] Dynamic subtest B-VGA1: SUCCESS (0.717s)
[188.885689] Starting dynamic subtest: A-HDMI-A1
[189.659215] Dynamic subtest A-HDMI-A1: SUCCESS (0.785s)
[189.675761] Starting dynamic subtest: B-HDMI-A1
[190.455317] Dynamic subtest B-HDMI-A1: SUCCESS (0.781s)
[190.456976] Subtest basic-plain-flip: SUCCESS (3.115s)
[191.091428] [113/171] (819s left) kms_force_connector_basic (force-connector-state)
[191.267643] Starting subtest: force-connector-state
[192.074427] Subtest force-connector-state: SUCCESS (0.806s)
[192.625238] [114/171] (818s left) kms_force_connector_basic (force-edid)
[192.805305] Starting subtest: force-edid
[193.127240] Subtest force-edid: SUCCESS (0.323s)
[193.589774] [115/171] (817s left) kms_force_connector_basic (force-load-detect)
[193.764887] Starting subtest: force-load-detect
[193.974805] Subtest force-load-detect: SUCCESS (0.209s)
[194.526403] [116/171] (816s left) kms_force_connector_basic (prune-stale-modes)
[194.698884] Starting subtest: prune-stale-modes
[195.009191] Subtest prune-stale-modes: SUCCESS (0.311s)
[195.458642] [117/171] (815s left) kms_frontbuffer_tracking (basic)
[196.124405] Starting subtest: basic
[196.410439] Subtest basic: SKIP (0.284s)
[196.522568] [118/171] (814s left) kms_pipe_crc_basic (compare-crc-sanitycheck)
[197.181882] Starting subtest: compare-crc-sanitycheck
[197.183604] Starting dynamic subtest: pipe-A-HDMI-A-1
[197.586806] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.407s)
[197.606100] Starting dynamic subtest: pipe-B-HDMI-A-1
[197.977965] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.386s)
[197.984964] Subtest compare-crc-sanitycheck: SUCCESS (0.802s)
[198.154861] [119/171] (812s left) kms_pipe_crc_basic (hang-read-crc)
[198.807928] Starting subtest: hang-read-crc
[198.809705] Starting dynamic subtest: pipe-A-HDMI-A-1
[199.835107] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.011s)
[199.861514] Starting dynamic subtest: pipe-B-HDMI-A-1
[200.851273] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.038s)
[200.853252] Subtest hang-read-crc: SUCCESS (2.053s)
[201.002380] [120/171] (810s left) kms_pipe_crc_basic (nonblocking-crc)
[201.675291] Starting subtest: nonblocking-crc
[201.677093] Starting dynamic subtest: pipe-A-HDMI-A-1
[202.245950] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.569s)
[202.262679] Starting dynamic subtest: pipe-B-HDMI-A-1
[202.842583] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.592s)
[202.844753] Subtest nonblocking-crc: SUCCESS (1.168s)
[203.231267] [121/171] (807s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[203.876712] Starting subtest: nonblocking-crc-frame-sequence
[203.878527] Starting dynamic subtest: pipe-A-HDMI-A-1
[204.440068] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.563s)
[204.460829] Starting dynamic subtest: pipe-B-HDMI-A-1
[205.028966] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.581s)
[205.030642] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.151s)
[205.204127] [122/171] (805s left) kms_pipe_crc_basic (read-crc)
[205.868904] Starting subtest: read-crc
[205.870604] Starting dynamic subtest: pipe-A-HDMI-A-1
[206.363436] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.499s)
[206.381419] Starting dynamic subtest: pipe-B-HDMI-A-1
[206.915681] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.549s)
[206.917463] Subtest read-crc: SUCCESS (1.052s)
[207.084848] [123/171] (804s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[207.745942] Starting subtest: read-crc-frame-sequence
[207.747673] Starting dynamic subtest: pipe-A-HDMI-A-1
[208.245680] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.504s)
[208.264683] Starting dynamic subtest: pipe-B-HDMI-A-1
[208.802797] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.555s)
[208.804680] Subtest read-crc-frame-sequence: SUCCESS (1.063s)
[208.977101] [124/171] (802s left) kms_psr (primary_page_flip)
[209.096382] Subtest primary_page_flip: SKIP (0.000s)
[209.131724] [125/171] (802s left) kms_psr (cursor_plane_move)
[209.245303] Subtest cursor_plane_move: SKIP (0.000s)
[209.281719] [126/171] (801s left) kms_psr (sprite_plane_onoff)
[209.395232] Subtest sprite_plane_onoff: SKIP (0.000s)
[209.431340] [127/171] (801s left) kms_psr (primary_mmap_gtt)
[209.545091] Subtest primary_mmap_gtt: SKIP (0.000s)
[209.580914] [128/171] (801s left) kms_setmode (basic-clone-single-crtc)
[209.695595] Starting subtest: basic-clone-single-crtc
[209.700641] Subtest basic-clone-single-crtc: SKIP (0.000s)
[209.758506] [129/171] (801s left) i915_pm_backlight (basic-brightness)
[210.404572] Subtest basic-brightness: SKIP (0.000s)
[210.462464] [130/171] (800s left) i915_pm_rpm (basic-pci-d3-state)
[222.434198] Subtest basic-pci-d3-state: SKIP (0.000s)
[222.704937] [131/171] (788s left) i915_pm_rpm (basic-rte)
[222.813130] Starting subtest: basic-rte
[234.722972] Subtest basic-rte: SKIP (11.885s)
[234.963518] [132/171] (776s left) i915_pm_rps (basic-api)
[235.077502] Subtest basic-api: SKIP (0.000s)
[235.113989] [133/171] (776s left) prime_self_import (basic-llseek-bad)
[235.224816] Starting subtest: basic-llseek-bad
[235.226574] Subtest basic-llseek-bad: SUCCESS (0.002s)
[235.292826] [134/171] (776s left) prime_self_import (basic-llseek-size)
[235.401399] Starting subtest: basic-llseek-size
[235.403077] Subtest basic-llseek-size: SUCCESS (0.003s)
[235.474239] [135/171] (775s left) prime_self_import (basic-with_fd_dup)
[235.581894] Starting subtest: basic-with_fd_dup
[235.583590] Subtest basic-with_fd_dup: SUCCESS (0.003s)
[235.658361] [136/171] (775s left) prime_self_import (basic-with_one_bo)
[235.770046] Starting subtest: basic-with_one_bo
[235.772030] Subtest basic-with_one_bo: SUCCESS (0.005s)
[235.829965] [137/171] (775s left) prime_self_import (basic-with_one_bo_two_files)
[235.934863] Starting subtest: basic-with_one_bo_two_files
[235.936808] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s)
[236.008807] [138/171] (775s left) prime_self_import (basic-with_two_bos)
[236.117734] Starting subtest: basic-with_two_bos
[236.119784] Subtest basic-with_two_bos: SUCCESS (0.003s)
[236.192700] [139/171] (775s left) prime_vgem (basic-fence-flip)
[236.324503] Starting subtest: basic-fence-flip
[237.415994] Subtest basic-fence-flip: SUCCESS (1.093s)
[237.611874] [140/171] (773s left) prime_vgem (basic-fence-mmap)
[237.742535] Starting subtest: basic-fence-mmap
[237.777783] Subtest basic-fence-mmap: SUCCESS (0.034s)
[237.843709] [141/171] (773s left) prime_vgem (basic-fence-read)
[237.958156] Starting subtest: basic-fence-read
[238.020617] Subtest basic-fence-read: SUCCESS (0.063s)
[238.098422] [142/171] (773s left) prime_vgem (basic-gtt)
[238.229541] Starting subtest: basic-gtt
[238.245015] Subtest basic-gtt: SUCCESS (0.018s)
[238.329510] [143/171] (773s left) prime_vgem (basic-read)
[238.458217] Starting subtest: basic-read
[238.486781] Subtest basic-read: SUCCESS (0.029s)
[238.580523] [144/171] (773s left) prime_vgem (basic-write)
[238.710537] Starting subtest: basic-write
[238.736805] Subtest basic-write: SUCCESS (0.031s)
[238.811802] [145/171] (772s left) prime_vgem (basic-userptr)
[238.941249] Starting subtest: basic-userptr
[238.954251] Subtest basic-userptr: SKIP (0.013s)
[239.030384] [146/171] (772s left) vgem_basic (setversion)
[239.152664] Starting subtest: setversion
[239.156765] Subtest setversion: SUCCESS (0.000s)
[239.211126] [147/171] (772s left) vgem_basic (create)
[239.334529] Starting subtest: create
[239.336777] Subtest create: SUCCESS (0.001s)
[239.393149] [148/171] (772s left) vgem_basic (debugfs)
[239.500094] Starting subtest: debugfs
[239.502184] Subtest debugfs: SUCCESS (0.001s)
[239.560234] [149/171] (772s left) vgem_basic (dmabuf-export)
[239.684753] Starting subtest: dmabuf-export
[239.687130] Subtest dmabuf-export: SUCCESS (0.002s)
[239.760193] [150/171] (771s left) vgem_basic (dmabuf-fence)
[239.883617] Starting subtest: dmabuf-fence
[239.885793] Subtest dmabuf-fence: SUCCESS (0.001s)
[239.943142] [151/171] (771s left) vgem_basic (dmabuf-fence-before)
[240.050761] Starting subtest: dmabuf-fence-before
[240.052738] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[240.108574] [152/171] (771s left) vgem_basic (dmabuf-mmap)
[240.213945] Starting subtest: dmabuf-mmap
[240.238027] Subtest dmabuf-mmap: SUCCESS (0.024s)
[240.293069] [153/171] (771s left) vgem_basic (mmap)
[240.415400] Starting subtest: mmap
[240.431770] Subtest mmap: SUCCESS (0.018s)
[240.493867] [154/171] (771s left) vgem_basic (second-client)
[240.614975] Starting subtest: second-client
[240.663074] Subtest second-client: SUCCESS (0.049s)
[240.723791] [155/171] (771s left) vgem_basic (sysfs)
[240.846451] Starting subtest: sysfs
[240.848701] Subtest sysfs: SUCCESS (0.001s)
[240.906689] [156/171] (770s left) core_hotunplug (unbind-rebind)
[241.029126] Starting subtest: unbind-rebind
[242.497040] Subtest unbind-rebind: SUCCESS (1.426s)
[242.603226] [157/171] (769s left) vgem_basic (unload)
[242.797121] Starting subtest: unload
[271.538766] Subtest unload: SUCCESS (28.775s)
[271.640910] [158/171] (740s left) i915_module_load (reload)
[271.746952] Starting subtest: reload
[274.145686] Subtest reload: SUCCESS (2.397s)
[274.181321] [159/171] (737s left) gem_lmem_swapping (basic)
[274.386493] Subtest basic: SKIP (0.000s)
[274.422358] [160/171] (737s left) gem_lmem_swapping (parallel-random-engines)
[274.539530] Subtest parallel-random-engines: SKIP (0.000s)
[274.572167] [161/171] (737s left) gem_lmem_swapping (random-engines)
[274.689035] Subtest random-engines: SKIP (0.000s)
[274.721755] [162/171] (737s left) gem_lmem_swapping (verify-random)
[274.838217] Subtest verify-random: SKIP (0.000s)
[274.871438] [163/171] (737s left) i915_pm_rpm (module-reload)
[286.874567] Subtest module-reload: SKIP (0.000s)
[287.130538] [164/171] (724s left) i915_selftest (live)
[287.797872] Starting subtest: live
[287.799944] Starting dynamic subtest: sanitycheck
[288.513196] Dynamic subtest sanitycheck: SUCCESS (0.716s)
[288.528889] Starting dynamic subtest: uncore
[289.206727] Dynamic subtest uncore: SUCCESS (0.692s)
[289.217063] Starting dynamic subtest: workarounds
[289.935519] Dynamic subtest workarounds: SUCCESS (0.727s)
[289.945950] Starting dynamic subtest: gt_engines
[290.640530] Dynamic subtest gt_engines: SUCCESS (0.704s)
[290.650127] Starting dynamic subtest: gt_timelines
[295.595386] Dynamic subtest gt_timelines: SUCCESS (4.951s)
[295.605490] Starting dynamic subtest: gt_contexts
[296.364294] Dynamic subtest gt_contexts: SUCCESS (0.771s)
[296.375374] Starting dynamic subtest: gt_lrc
[297.028912] Dynamic subtest gt_lrc: SUCCESS (0.664s)
[297.039768] Starting dynamic subtest: gt_mocs
[297.731857] Dynamic subtest gt_mocs: SUCCESS (0.702s)
[297.742803] Starting dynamic subtest: gt_pm
[298.917630] Dynamic subtest gt_pm: SUCCESS (1.184s)
[298.929410] Starting dynamic subtest: gt_heartbeat
[299.649921] Dynamic subtest gt_heartbeat: SUCCESS (0.731s)
[299.661763] Starting dynamic subtest: requests
[303.879417] Dynamic subtest requests: SUCCESS (4.228s)
[303.891566] Starting dynamic subtest: migrate
[304.556411] Dynamic subtest migrate: SUCCESS (0.676s)
[304.567730] Starting dynamic subtest: active
[305.277794] Dynamic subtest active: SUCCESS (0.720s)
[305.289287] Starting dynamic subtest: objects
[307.580164] Dynamic subtest objects: SUCCESS (2.300s)
[307.590534] Starting dynamic subtest: mman
[313.573642] Dynamic subtest mman: SUCCESS (5.994s)
[313.585246] Starting dynamic subtest: dmabuf
[314.345183] Dynamic subtest dmabuf: SUCCESS (0.769s)
[314.355396] Starting dynamic subtest: vma
[315.072641] Dynamic subtest vma: SUCCESS (0.727s)
[315.084041] Starting dynamic subtest: coherency
[316.821654] Dynamic subtest coherency: SUCCESS (1.748s)
[316.832849] Starting dynamic subtest: gtt
[320.774264] Dynamic subtest gtt: SUCCESS (3.952s)
[320.785379] Starting dynamic subtest: gem
[321.668698] Dynamic subtest gem: SUCCESS (0.893s)
[321.678561] Starting dynamic subtest: evict
[322.336226] Dynamic subtest evict: SUCCESS (0.666s)
[322.352854] Starting dynamic subtest: hugepages
[322.999215] Dynamic subtest hugepages: SUCCESS (0.662s)
[323.010836] Starting dynamic subtest: gem_contexts
[326.732865] Dynamic subtest gem_contexts: SUCCESS (3.732s)
[326.744086] Starting dynamic subtest: client
[327.419068] Dynamic subtest client: SUCCESS (0.685s)
[327.430835] Starting dynamic subtest: gem_migrate
[328.085099] Dynamic subtest gem_migrate: SUCCESS (0.665s)
[328.099914] Starting dynamic subtest: reset
[328.912264] Dynamic subtest reset: SUCCESS (0.826s)
[328.923182] Starting dynamic subtest: memory_region
[329.598259] Dynamic subtest memory_region: SUCCESS (0.685s)
[329.609440] Starting dynamic subtest: hangcheck
[331.831417] Dynamic subtest hangcheck: SUCCESS (2.232s)
[331.843144] Starting dynamic subtest: execlists
[332.551720] Dynamic subtest execlists: SUCCESS (0.719s)
[332.563653] Starting dynamic subtest: ring_submission
[333.237946] Dynamic subtest ring_submission: SUCCESS (0.685s)
[333.247928] Starting dynamic subtest: perf
[333.934321] Dynamic subtest perf: SUCCESS (0.695s)
[333.948101] Starting dynamic subtest: slpc
[334.679552] Dynamic subtest slpc: SUCCESS (0.744s)
[334.690965] Starting dynamic subtest: guc
[335.418958] Dynamic subtest guc: SUCCESS (0.738s)
[335.431801] Starting dynamic subtest: guc_multi_lrc
[336.125529] Dynamic subtest guc_multi_lrc: SUCCESS (0.705s)
[336.136190] Starting dynamic subtest: guc_hang
[336.795968] Dynamic subtest guc_hang: SUCCESS (0.670s)
[336.810886] Starting dynamic subtest: late_gt_pm
[337.467626] Dynamic subtest late_gt_pm: SUCCESS (0.668s)
[337.470867] Subtest live: SUCCESS (49.669s)
[337.542653] [165/171] (674s left) dmabuf (all-tests)
[337.672602] Starting subtest: all-tests
[337.674742] Starting dynamic subtest: sanitycheck
[337.687070] Dynamic subtest sanitycheck: SUCCESS (0.021s)
[337.695559] Starting dynamic subtest: dma_fence
[337.826076] Dynamic subtest dma_fence: SUCCESS (0.136s)
[337.836377] Starting dynamic subtest: dma_fence_chain
[354.848903] Dynamic subtest dma_fence_chain: SUCCESS (17.022s)
[354.861070] Starting dynamic subtest: dma_fence_unwrap
[354.874461] Dynamic subtest dma_fence_unwrap: SUCCESS (0.026s)
[354.892768] Starting dynamic subtest: dma_resv
[354.905794] Dynamic subtest dma_resv: SUCCESS (0.021s)
[354.907772] Subtest all-tests: SUCCESS (17.230s)
[354.922131] [166/171] (657s left) i915_suspend (basic-s2idle-without-i915)
[355.031463] Starting subtest: basic-s2idle-without-i915
[373.695405] Subtest basic-s2idle-without-i915: SUCCESS (3.240s)
[375.955696] [167/171] (653s left) i915_suspend (basic-s3-without-i915)
[376.071751] Starting subtest: basic-s3-without-i915
[393.996347] Subtest basic-s3-without-i915: SUCCESS (2.382s)
[400.886234] [168/171] (650s left) gem_exec_suspend (basic-s0)
[401.015557] Starting subtest: basic-S0
[401.017389] Starting dynamic subtest: smem
[418.445839] Dynamic subtest smem: SUCCESS (7.211s)
[418.447723] Subtest basic-S0: SUCCESS (7.212s)
[421.651758] [169/171] (643s left) gem_exec_suspend (basic-s3)
[421.781804] Starting subtest: basic-S3
[421.783687] Starting dynamic subtest: smem
[439.439072] Dynamic subtest smem: SUCCESS (2.104s)
[439.440707] Subtest basic-S3: SUCCESS (2.105s)
[446.624862] [170/171] (641s left) kms_chamelium_hpd (common-hpd-after-suspend)
[447.436636] Subtest common-hpd-after-suspend: SKIP (0.000s)
[447.794030] [171/171] (639s left) kms_pipe_crc_basic (suspend-read-crc)
[448.444835] Starting subtest: suspend-read-crc
[448.451761] Starting dynamic subtest: pipe-A-HDMI-A-1
[466.559159] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.102s)
[466.576744] Starting dynamic subtest: pipe-B-HDMI-A-1
[484.543380] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.141s)
[484.545180] Subtest suspend-read-crc: SUCCESS (4.247s)
[491.911447] Closing watchdogs
Done.