[42.435988] Initializing watchdogs
[42.436055]   /dev/watchdog0
[42.440403] [001/165] (960s left) i915_module_load (load)
[42.548570] Starting subtest: load
[49.303580] Subtest load: SUCCESS (6.755s)
[49.314396] [002/165] (953s left) core_auth (basic-auth)
[49.419105] Starting subtest: basic-auth
[49.421067] Subtest basic-auth: SUCCESS (0.002s)
[49.528341] [003/165] (953s left) debugfs_test (read_all_entries)
[49.611944] Starting subtest: read_all_entries
[50.045564] Subtest read_all_entries: SUCCESS (0.426s)
[50.189227] [004/165] (952s left) debugfs_test (basic-hwmon)
[50.278277] Starting subtest: basic-hwmon
[50.282569] Subtest basic-hwmon: SUCCESS (0.004s)
[50.387618] [005/165] (952s left) fbdev (eof)
[50.437265] Starting subtest: eof
[50.438234] Subtest eof: SUCCESS (0.000s)
[50.503775] [006/165] (952s left) fbdev (info)
[50.545651] Starting subtest: info
[50.546903] Subtest info: SUCCESS (0.000s)
[50.620592] [007/165] (952s left) fbdev (nullptr)
[50.687358] Starting subtest: nullptr
[50.688376] Subtest nullptr: SUCCESS (0.000s)
[50.755233] [008/165] (952s left) fbdev (read)
[50.820847] Starting subtest: read
[62.983569] Subtest read: SUCCESS (12.163s)
[63.036700] [009/165] (939s left) fbdev (write)
[63.087401] Starting subtest: write
[69.132132] Subtest write: SUCCESS (6.044s)
[69.187481] [010/165] (933s left) gem_basic (bad-close)
[69.243904] Starting subtest: bad-close
[69.245548] Subtest bad-close: SUCCESS (0.000s)
[69.337430] [011/165] (933s left) gem_basic (create-close)
[69.400212] Starting subtest: create-close
[69.402524] Subtest create-close: SUCCESS (0.000s)
[69.499949] [012/165] (933s left) gem_basic (create-fd-close)
[69.561405] Starting subtest: create-fd-close
[69.563613] Subtest create-fd-close: SUCCESS (0.000s)
[69.649131] [013/165] (933s left) gem_busy (busy@all-engines)
[69.745058] Starting subtest: busy
[69.746039] Starting dynamic subtest: all-engines
[69.860160] Dynamic subtest all-engines: SUCCESS (0.115s)
[69.860968] Subtest busy: SUCCESS (0.116s)
[70.265275] [014/165] (932s left) gem_close_race (basic-process)
[70.391866] Starting subtest: basic-process
[70.443560] Subtest basic-process: SUCCESS (0.052s)
[70.682635] [015/165] (932s left) gem_close_race (basic-threads)
[70.773928] Starting subtest: basic-threads
[72.019282] Subtest basic-threads: SUCCESS (1.245s)
[72.268844] [016/165] (930s left) gem_ctx_create (basic)
[72.387237] Starting subtest: basic
[72.388078] Subtest basic: SUCCESS (0.000s)
[72.602282] [017/165] (930s left) gem_ctx_create (basic-files)
[72.678429] Starting subtest: basic-files
[74.691370] Subtest basic-files: SUCCESS (2.013s)
[75.220694] [018/165] (927s left) gem_ctx_exec (basic)
[75.277809] Starting subtest: basic
[75.282750] Subtest basic: SUCCESS (0.005s)
[75.400880] [019/165] (927s left) gem_exec_basic (basic)
[75.489255] Starting subtest: basic
[75.490100] Starting dynamic subtest: rcs0-smem
[75.491816] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[75.496941] Starting dynamic subtest: bcs0-smem
[75.497746] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[75.502840] Starting dynamic subtest: vcs0-smem
[75.503620] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[75.508141] Starting dynamic subtest: vcs1-smem
[75.508933] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[75.513464] Starting dynamic subtest: vecs0-smem
[75.514263] Dynamic subtest vecs0-smem: SUCCESS (0.000s)
[75.518787] Starting dynamic subtest: vecs1-smem
[75.520144] Dynamic subtest vecs1-smem: SUCCESS (0.001s)
[75.525232] Starting dynamic subtest: ccs0-smem
[75.526217] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[75.531164] Starting dynamic subtest: ccs1-smem
[75.532015] Dynamic subtest ccs1-smem: SUCCESS (0.001s)
[75.536512] Starting dynamic subtest: ccs2-smem
[75.537451] Dynamic subtest ccs2-smem: SUCCESS (0.001s)
[75.542188] Starting dynamic subtest: ccs3-smem
[75.543360] Dynamic subtest ccs3-smem: SUCCESS (0.001s)
[75.548465] Starting dynamic subtest: rcs0-lmem0
[75.549634] Dynamic subtest rcs0-lmem0: SUCCESS (0.001s)
[75.554574] Starting dynamic subtest: bcs0-lmem0
[75.555643] Dynamic subtest bcs0-lmem0: SUCCESS (0.000s)
[75.560677] Starting dynamic subtest: vcs0-lmem0
[75.561948] Dynamic subtest vcs0-lmem0: SUCCESS (0.000s)
[75.567049] Starting dynamic subtest: vcs1-lmem0
[75.568214] Dynamic subtest vcs1-lmem0: SUCCESS (0.000s)
[75.573233] Starting dynamic subtest: vecs0-lmem0
[75.574496] Dynamic subtest vecs0-lmem0: SUCCESS (0.000s)
[75.579304] Starting dynamic subtest: vecs1-lmem0
[75.580127] Dynamic subtest vecs1-lmem0: SUCCESS (0.000s)
[75.585145] Starting dynamic subtest: ccs0-lmem0
[75.586451] Dynamic subtest ccs0-lmem0: SUCCESS (0.000s)
[75.591640] Starting dynamic subtest: ccs1-lmem0
[75.592659] Dynamic subtest ccs1-lmem0: SUCCESS (0.000s)
[75.597630] Starting dynamic subtest: ccs2-lmem0
[75.598862] Dynamic subtest ccs2-lmem0: SUCCESS (0.000s)
[75.603442] Starting dynamic subtest: ccs3-lmem0
[75.604336] Dynamic subtest ccs3-lmem0: SUCCESS (0.000s)
[75.605230] Subtest basic: SUCCESS (0.013s)
[75.683292] [020/165] (927s left) gem_exec_create (basic)
[75.757489] Starting subtest: basic
[75.758486] Starting dynamic subtest: smem
[77.852252] Dynamic subtest smem: SUCCESS (2.094s)
[77.857117] Starting dynamic subtest: lmem0
[79.946994] Dynamic subtest lmem0: SUCCESS (2.095s)
[79.948166] Subtest basic: SUCCESS (4.189s)
[80.126147] [021/165] (923s left) gem_exec_fence (basic-busy)
[80.327788] Starting subtest: basic-busy
[80.328694] Starting dynamic subtest: rcs0
[80.438760] Dynamic subtest rcs0: SUCCESS (0.110s)
[80.458683] Starting dynamic subtest: bcs0
[80.496285] Dynamic subtest bcs0: SUCCESS (0.057s)
[80.517665] Starting dynamic subtest: vcs0
[80.551115] Dynamic subtest vcs0: SUCCESS (0.055s)
[80.572107] Starting dynamic subtest: vcs1
[80.611282] Dynamic subtest vcs1: SUCCESS (0.060s)
[80.632138] Starting dynamic subtest: vecs0
[80.669308] Dynamic subtest vecs0: SUCCESS (0.057s)
[80.690319] Starting dynamic subtest: vecs1
[80.722195] Dynamic subtest vecs1: SUCCESS (0.053s)
[80.743240] Starting dynamic subtest: ccs0
[80.776196] Dynamic subtest ccs0: SUCCESS (0.054s)
[80.797313] Starting dynamic subtest: ccs1
[80.837947] Dynamic subtest ccs1: SUCCESS (0.061s)
[80.847179] Starting dynamic subtest: ccs2
[80.887720] Dynamic subtest ccs2: SUCCESS (0.050s)
[80.894195] Starting dynamic subtest: ccs3
[80.945074] Dynamic subtest ccs3: SUCCESS (0.056s)
[80.947126] Subtest basic-busy: SUCCESS (0.617s)
[81.945805] [022/165] (921s left) gem_exec_fence (basic-wait)
[82.135475] Starting subtest: basic-wait
[82.136434] Starting dynamic subtest: rcs0
[82.230965] Dynamic subtest rcs0: SUCCESS (0.095s)
[82.238850] Starting dynamic subtest: bcs0
[82.284944] Dynamic subtest bcs0: SUCCESS (0.054s)
[82.296527] Starting dynamic subtest: vcs0
[82.339186] Dynamic subtest vcs0: SUCCESS (0.053s)
[82.361617] Starting dynamic subtest: vcs1
[82.398110] Dynamic subtest vcs1: SUCCESS (0.058s)
[82.420153] Starting dynamic subtest: vecs0
[82.456948] Dynamic subtest vecs0: SUCCESS (0.059s)
[82.469018] Starting dynamic subtest: vecs1
[82.513172] Dynamic subtest vecs1: SUCCESS (0.055s)
[82.534966] Starting dynamic subtest: ccs0
[82.574400] Dynamic subtest ccs0: SUCCESS (0.061s)
[82.596207] Starting dynamic subtest: ccs1
[82.636108] Dynamic subtest ccs1: SUCCESS (0.061s)
[82.658073] Starting dynamic subtest: ccs2
[82.698159] Dynamic subtest ccs2: SUCCESS (0.062s)
[82.720723] Starting dynamic subtest: ccs3
[82.753214] Dynamic subtest ccs3: SUCCESS (0.055s)
[82.755287] Subtest basic-wait: SUCCESS (0.617s)
[83.726076] [023/165] (919s left) gem_exec_fence (basic-await)
[83.949184] Starting subtest: basic-await
[83.951088] Starting dynamic subtest: rcs0
[84.068754] Dynamic subtest rcs0: SUCCESS (0.121s)
[84.073718] Starting dynamic subtest: bcs0
[84.161682] Dynamic subtest bcs0: SUCCESS (0.093s)
[84.167514] Starting dynamic subtest: vcs0
[84.260029] Dynamic subtest vcs0: SUCCESS (0.098s)
[84.265198] Starting dynamic subtest: vcs1
[84.353995] Dynamic subtest vcs1: SUCCESS (0.094s)
[84.359620] Starting dynamic subtest: vecs0
[84.450203] Dynamic subtest vecs0: SUCCESS (0.096s)
[84.455378] Starting dynamic subtest: vecs1
[84.544473] Dynamic subtest vecs1: SUCCESS (0.094s)
[84.549898] Starting dynamic subtest: ccs0
[84.638780] Dynamic subtest ccs0: SUCCESS (0.094s)
[84.644546] Starting dynamic subtest: ccs1
[84.736572] Dynamic subtest ccs1: SUCCESS (0.098s)
[84.741729] Starting dynamic subtest: ccs2
[84.830844] Dynamic subtest ccs2: SUCCESS (0.094s)
[84.836564] Starting dynamic subtest: ccs3
[84.926574] Dynamic subtest ccs3: SUCCESS (0.096s)
[84.927405] Subtest basic-await: SUCCESS (0.979s)
[85.925590] [024/165] (917s left) gem_exec_fence (nb-await)
[86.155713] Starting subtest: nb-await
[86.157310] Starting dynamic subtest: rcs0
[86.257134] Dynamic subtest rcs0: SUCCESS (0.108s)
[86.262585] Starting dynamic subtest: bcs0
[86.320338] Dynamic subtest bcs0: SUCCESS (0.063s)
[86.328270] Starting dynamic subtest: vcs0
[86.385576] Dynamic subtest vcs0: SUCCESS (0.065s)
[86.394319] Starting dynamic subtest: vcs1
[86.459657] Dynamic subtest vcs1: SUCCESS (0.071s)
[86.467908] Starting dynamic subtest: vecs0
[86.524368] Dynamic subtest vecs0: SUCCESS (0.067s)
[86.530993] Starting dynamic subtest: vecs1
[86.588260] Dynamic subtest vecs1: SUCCESS (0.063s)
[86.597989] Starting dynamic subtest: ccs0
[86.662164] Dynamic subtest ccs0: SUCCESS (0.073s)
[86.686577] Starting dynamic subtest: ccs1
[86.756321] Dynamic subtest ccs1: SUCCESS (0.094s)
[86.773487] Starting dynamic subtest: ccs2
[86.840780] Dynamic subtest ccs2: SUCCESS (0.085s)
[86.852101] Starting dynamic subtest: ccs3
[86.917713] Dynamic subtest ccs3: SUCCESS (0.076s)
[86.919500] Subtest nb-await: SUCCESS (0.768s)
[87.873649] [025/165] (915s left) gem_exec_gttfill (basic)
[87.943192] Starting subtest: basic
[93.715542] Subtest basic: SUCCESS (5.772s)
[93.955845] [026/165] (909s left) gem_exec_parallel (engines)
[94.101070] Starting subtest: engines
[94.102039] Starting dynamic subtest: basic
[95.814808] Dynamic subtest basic: SUCCESS (1.714s)
[95.821013] Starting dynamic subtest: contexts
[99.848720] Dynamic subtest contexts: SUCCESS (4.033s)
[99.854656] Starting dynamic subtest: fds
[105.053550] Dynamic subtest fds: SUCCESS (5.205s)
[105.059237] Starting dynamic subtest: userptr
[106.695438] Dynamic subtest userptr: SUCCESS (1.642s)
[106.696723] Subtest engines: SUCCESS (12.594s)
[106.941850] [027/165] (896s left) gem_exec_store (basic)
[107.018536] Starting subtest: basic
[107.168024] Subtest basic: SUCCESS (0.149s)
[107.395320] [028/165] (896s left) gem_flink_basic (bad-flink)
[107.456039] Starting subtest: bad-flink
[107.457244] Subtest bad-flink: SUCCESS (0.000s)
[107.529258] [029/165] (895s left) gem_flink_basic (bad-open)
[107.598047] Starting subtest: bad-open
[107.599211] Subtest bad-open: SUCCESS (0.000s)
[107.683330] [030/165] (895s left) gem_flink_basic (basic)
[107.769895] Starting subtest: basic
[107.770731] Subtest basic: SUCCESS (0.000s)
[107.846403] [031/165] (895s left) gem_flink_basic (double-flink)
[107.903044] Starting subtest: double-flink
[107.903925] Subtest double-flink: SUCCESS (0.000s)
[107.983510] [032/165] (895s left) gem_flink_basic (flink-lifetime)
[108.038889] Starting subtest: flink-lifetime
[108.040919] Subtest flink-lifetime: SUCCESS (0.003s)
[108.156242] [033/165] (895s left) gem_huc_copy (huc-copy)
[108.254835] Starting subtest: huc-copy
[108.260329] Subtest huc-copy: SUCCESS (0.005s)
[108.386146] [034/165] (895s left) gem_linear_blits (basic)
[108.518821] Starting subtest: basic
[108.548196] Subtest basic: SUCCESS (0.029s)
[108.705105] [035/165] (894s left) gem_mmap (basic)
[108.804755] Subtest basic: SKIP (0.000s)
[108.849529] [036/165] (894s left) gem_mmap_gtt (basic)
[108.942431] Subtest basic: SKIP (0.000s)
[108.979144] [037/165] (894s left) gem_render_linear_blits (basic)
[109.048357] Starting subtest: basic
[109.103819] Subtest basic: SUCCESS (0.055s)
[109.163232] [038/165] (894s left) gem_render_tiled_blits (basic)
[109.232324] Subtest basic: SKIP (0.000s)
[109.263410] [039/165] (894s left) gem_ringfill (basic-all)
[109.662917] Starting subtest: basic-all
[112.096769] Subtest basic-all: SUCCESS (2.434s)
[112.183072] [040/165] (891s left) gem_softpin (allocator-basic)
[112.252682] Starting subtest: allocator-basic
[112.424822] Subtest allocator-basic: SUCCESS (0.172s)
[112.543868] [041/165] (891s left) gem_softpin (allocator-basic-reserve)
[112.634959] Starting subtest: allocator-basic-reserve
[112.810595] Subtest allocator-basic-reserve: SUCCESS (0.175s)
[112.957689] [042/165] (890s left) gem_softpin (safe-alignment)
[113.047192] Starting subtest: safe-alignment
[113.101134] Subtest safe-alignment: SUCCESS (0.054s)
[113.209512] [043/165] (890s left) gem_sync (basic-all)
[113.304151] Starting subtest: basic-all
[115.381402] Subtest basic-all: SUCCESS (2.078s)
[115.581595] [044/165] (888s left) gem_sync (basic-each)
[115.649064] Starting subtest: basic-each
[118.432926] Subtest basic-each: SUCCESS (2.784s)
[118.672483] [045/165] (885s left) gem_tiled_blits (basic)
[118.776719] Subtest basic: SKIP (0.000s)
[118.812901] [046/165] (884s left) gem_tiled_fence_blits (basic)
[118.878830] Subtest basic: SKIP (0.000s)
[118.930457] [047/165] (884s left) gem_tiled_pread_basic
[119.046781] [048/165] (884s left) gem_wait (busy@all-engines)
[119.127158] Starting subtest: busy
[119.128154] Starting dynamic subtest: all-engines
[119.699538] Dynamic subtest all-engines: SUCCESS (0.572s)
[119.700526] Subtest busy: SUCCESS (0.573s)
[119.926659] [049/165] (883s left) gem_wait (wait@all-engines)
[119.996874] Starting subtest: wait
[119.997758] Starting dynamic subtest: all-engines
[121.092380] Dynamic subtest all-engines: SUCCESS (1.095s)
[121.093512] Subtest wait: SUCCESS (1.095s)
[121.337708] [050/165] (882s left) i915_getparams_basic (basic-eu-total)
[121.399069] Starting subtest: basic-eu-total
[121.401401] Subtest basic-eu-total: SUCCESS (0.000s)
[121.507352] [051/165] (882s left) i915_getparams_basic (basic-subslice-total)
[121.592853] Starting subtest: basic-subslice-total
[121.594441] Subtest basic-subslice-total: SUCCESS (0.000s)
[121.661023] [052/165] (882s left) i915_hangman (error-state-basic)
[121.757352] Starting subtest: error-state-basic
[121.936763] Subtest error-state-basic: SUCCESS (0.180s)
[122.009606] [053/165] (881s left) i915_pciid
[122.174529] [054/165] (881s left) kms_addfb_basic (addfb25-4-tiled)
[122.314608] Starting subtest: addfb25-4-tiled
[122.315474] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[122.396072] [055/165] (881s left) kms_addfb_basic (addfb25-bad-modifier)
[122.472109] Starting subtest: addfb25-bad-modifier
[122.472991] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[122.596484] [056/165] (881s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[122.673932] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[122.797166] [057/165] (881s left) kms_addfb_basic (addfb25-modifier-no-flag)
[122.880376] Starting subtest: addfb25-modifier-no-flag
[122.881407] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[122.992297] [058/165] (880s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[123.056065] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[123.178913] [059/165] (880s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[123.256992] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[123.376859] [060/165] (880s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[123.495545] Starting subtest: addfb25-yf-tiled-legacy
[123.496457] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[123.579472] [061/165] (880s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[123.695154] Starting subtest: addfb25-y-tiled-legacy
[123.696012] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[123.779300] [062/165] (880s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[123.887752] Starting subtest: addfb25-y-tiled-small-legacy
[123.889445] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[123.980699] [063/165] (880s left) kms_addfb_basic (bad-pitch-0)
[124.061805] Starting subtest: bad-pitch-0
[124.062644] Subtest bad-pitch-0: SUCCESS (0.000s)
[124.180043] [064/165] (879s left) kms_addfb_basic (bad-pitch-1024)
[124.257197] Starting subtest: bad-pitch-1024
[124.258247] Subtest bad-pitch-1024: SUCCESS (0.000s)
[124.379248] [065/165] (879s left) kms_addfb_basic (bad-pitch-128)
[124.456858] Starting subtest: bad-pitch-128
[124.457596] Subtest bad-pitch-128: SUCCESS (0.000s)
[124.578879] [066/165] (879s left) kms_addfb_basic (bad-pitch-256)
[124.654068] Starting subtest: bad-pitch-256
[124.655059] Subtest bad-pitch-256: SUCCESS (0.000s)
[124.782196] [067/165] (879s left) kms_addfb_basic (bad-pitch-32)
[124.855730] Starting subtest: bad-pitch-32
[124.856507] Subtest bad-pitch-32: SUCCESS (0.000s)
[124.979621] [068/165] (879s left) kms_addfb_basic (bad-pitch-63)
[125.065010] Starting subtest: bad-pitch-63
[125.065918] Subtest bad-pitch-63: SUCCESS (0.000s)
[125.198308] [069/165] (878s left) kms_addfb_basic (bad-pitch-65536)
[125.277971] Starting subtest: bad-pitch-65536
[125.278960] Subtest bad-pitch-65536: SUCCESS (0.000s)
[125.393718] [070/165] (878s left) kms_addfb_basic (bad-pitch-999)
[125.463058] Starting subtest: bad-pitch-999
[125.463937] Subtest bad-pitch-999: SUCCESS (0.000s)
[125.575231] [071/165] (878s left) kms_addfb_basic (basic)
[125.646854] Starting subtest: basic
[125.648838] Subtest basic: SUCCESS (0.000s)
[125.775704] [072/165] (878s left) kms_addfb_basic (basic-x-tiled-legacy)
[125.844924] Starting subtest: basic-x-tiled-legacy
[125.846532] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[125.963090] [073/165] (878s left) kms_addfb_basic (basic-y-tiled-legacy)
[126.044857] Starting subtest: basic-y-tiled-legacy
[126.046399] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[126.163376] [074/165] (878s left) kms_addfb_basic (bo-too-small)
[126.282253] Starting subtest: bo-too-small
[126.283057] Subtest bo-too-small: SUCCESS (0.000s)
[126.361629] [075/165] (877s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[126.478728] Starting subtest: bo-too-small-due-to-tiling
[126.480498] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[126.563527] [076/165] (877s left) kms_addfb_basic (clobberred-modifier)
[126.640162] Starting subtest: clobberred-modifier
[126.641984] Subtest clobberred-modifier: SKIP (0.000s)
[126.762962] [077/165] (877s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[126.846489] Starting subtest: framebuffer-vs-set-tiling
[126.848637] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[126.958563] [078/165] (877s left) kms_addfb_basic (invalid-get-prop)
[127.024847] Starting subtest: invalid-get-prop
[127.025699] Subtest invalid-get-prop: SUCCESS (0.000s)
[127.145301] [079/165] (877s left) kms_addfb_basic (invalid-get-prop-any)
[127.219938] Starting subtest: invalid-get-prop-any
[127.220816] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[127.349053] [080/165] (876s left) kms_addfb_basic (invalid-set-prop)
[127.432116] Starting subtest: invalid-set-prop
[127.433112] Subtest invalid-set-prop: SUCCESS (0.000s)
[127.543330] [081/165] (876s left) kms_addfb_basic (invalid-set-prop-any)
[127.608126] Starting subtest: invalid-set-prop-any
[127.609123] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[127.728298] [082/165] (876s left) kms_addfb_basic (no-handle)
[127.802197] Starting subtest: no-handle
[127.803272] Subtest no-handle: SUCCESS (0.000s)
[127.930902] [083/165] (876s left) kms_addfb_basic (size-max)
[128.052375] Starting subtest: size-max
[128.053309] Subtest size-max: SUCCESS (0.000s)
[128.126474] [084/165] (876s left) kms_addfb_basic (small-bo)
[128.240741] Starting subtest: small-bo
[128.241638] Subtest small-bo: SUCCESS (0.000s)
[128.309998] [085/165] (876s left) kms_addfb_basic (tile-pitch-mismatch)
[128.387285] Starting subtest: tile-pitch-mismatch
[128.389408] Subtest tile-pitch-mismatch: SKIP (0.000s)
[128.534962] [086/165] (875s left) kms_addfb_basic (too-high)
[128.665170] Starting subtest: too-high
[128.666048] Subtest too-high: SUCCESS (0.001s)
[128.744457] [087/165] (875s left) kms_addfb_basic (too-wide)
[128.850612] Starting subtest: too-wide
[128.851505] Subtest too-wide: SUCCESS (0.000s)
[128.927665] [088/165] (875s left) kms_addfb_basic (unused-handle)
[128.993044] Starting subtest: unused-handle
[128.993976] Subtest unused-handle: SUCCESS (0.000s)
[129.132484] [089/165] (875s left) kms_addfb_basic (unused-modifier)
[129.208950] Starting subtest: unused-modifier
[129.209934] Subtest unused-modifier: SUCCESS (0.000s)
[129.329565] [090/165] (875s left) kms_addfb_basic (unused-offsets)
[129.403133] Starting subtest: unused-offsets
[129.404050] Subtest unused-offsets: SUCCESS (0.000s)
[129.530542] [091/165] (874s left) kms_addfb_basic (unused-pitches)
[129.602942] Starting subtest: unused-pitches
[129.603807] Subtest unused-pitches: SUCCESS (0.000s)
[129.709326] [092/165] (874s left) kms_busy (basic)
[129.811480] Starting subtest: basic
[129.812372] Starting dynamic subtest: flip
[130.555271] Dynamic subtest flip: SUCCESS (0.743s)
[130.569577] Starting dynamic subtest: modeset
[131.625686] Dynamic subtest modeset: SUCCESS (1.069s)
[131.627693] Subtest basic: SUCCESS (1.813s)
[131.890981] [093/165] (872s left) kms_prop_blob (basic)
[131.987783] Starting subtest: basic
[131.989643] Subtest basic: SUCCESS (0.000s)
[132.087639] [094/165] (872s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[132.181733] Starting subtest: basic-busy-flip-before-cursor-atomic
[132.183577] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[132.238343] [095/165] (872s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[132.335261] Starting subtest: basic-busy-flip-before-cursor-legacy
[132.336979] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[132.408533] [096/165] (872s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[132.513109] Starting subtest: basic-flip-after-cursor-atomic
[133.565782] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.050s)
[133.790402] [097/165] (870s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[133.916498] Starting subtest: basic-flip-after-cursor-legacy
[134.948951] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.041s)
[135.196864] [098/165] (869s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[135.315482] Starting subtest: basic-flip-after-cursor-varying-size
[136.355383] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.040s)
[136.596177] [099/165] (868s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[136.707670] Starting subtest: basic-flip-before-cursor-atomic
[137.750431] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.043s)
[138.027497] [100/165] (866s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[138.165315] Starting subtest: basic-flip-before-cursor-legacy
[139.203360] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.037s)
[139.467244] [101/165] (865s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[139.597933] Starting subtest: basic-flip-before-cursor-varying-size
[140.640740] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.044s)
[140.882371] [102/165] (863s left) kms_dsc (dsc-basic)
[140.976586] Starting subtest: dsc-basic
[140.977418] Starting dynamic subtest: pipe-A-DP-1
[141.666054] Dynamic subtest pipe-A-DP-1: SUCCESS (0.689s)
[141.699952] Starting dynamic subtest: pipe-B-DP-1
[142.069948] Dynamic subtest pipe-B-DP-1: SUCCESS (0.401s)
[142.102423] Starting dynamic subtest: pipe-C-DP-1
[142.461371] Dynamic subtest pipe-C-DP-1: SUCCESS (0.390s)
[142.471225] Starting dynamic subtest: pipe-D-DP-1
[142.823581] Dynamic subtest pipe-D-DP-1: SUCCESS (0.361s)
[142.824631] Subtest dsc-basic: SUCCESS (1.848s)
[143.139692] [103/165] (861s left) kms_flip (basic-flip-vs-dpms)
[143.250401] Starting subtest: basic-flip-vs-dpms
[143.253019] Starting dynamic subtest: A-DP1
[144.208926] Dynamic subtest A-DP1: SUCCESS (0.954s)
[144.235873] Starting dynamic subtest: B-DP1
[145.173034] Dynamic subtest B-DP1: SUCCESS (0.963s)
[145.192397] Starting dynamic subtest: C-DP1
[146.113623] Dynamic subtest C-DP1: SUCCESS (0.938s)
[146.121112] Starting dynamic subtest: D-DP1
[146.863430] Dynamic subtest D-DP1: SUCCESS (0.750s)
[146.870899] Subtest basic-flip-vs-dpms: SUCCESS (3.622s)
[147.152703] [104/165] (857s left) kms_flip (basic-flip-vs-modeset)
[147.280156] Starting subtest: basic-flip-vs-modeset
[147.282267] Starting dynamic subtest: A-DP1
[148.277832] Dynamic subtest A-DP1: SUCCESS (0.993s)
[148.297063] Starting dynamic subtest: B-DP1
[149.059631] Dynamic subtest B-DP1: SUCCESS (0.780s)
[149.076927] Starting dynamic subtest: C-DP1
[149.845177] Dynamic subtest C-DP1: SUCCESS (0.783s)
[149.862130] Starting dynamic subtest: D-DP1
[150.624174] Dynamic subtest D-DP1: SUCCESS (0.778s)
[150.632661] Subtest basic-flip-vs-modeset: SUCCESS (3.354s)
[150.896397] [105/165] (853s left) kms_flip (basic-flip-vs-wf_vblank)
[151.024705] Starting subtest: basic-flip-vs-wf_vblank
[151.027299] Starting dynamic subtest: A-DP1
[152.217341] Dynamic subtest A-DP1: SUCCESS (1.189s)
[152.232416] Starting dynamic subtest: B-DP1
[153.318432] Dynamic subtest B-DP1: SUCCESS (1.099s)
[153.325476] Starting dynamic subtest: C-DP1
[154.486410] Dynamic subtest C-DP1: SUCCESS (1.147s)
[154.502534] Starting dynamic subtest: D-DP1
[155.583219] Dynamic subtest D-DP1: SUCCESS (1.116s)
[155.586582] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.563s)
[155.865450] [106/165] (848s left) kms_flip (basic-plain-flip)
[155.974211] Starting subtest: basic-plain-flip
[155.976463] Starting dynamic subtest: A-DP1
[156.879208] Dynamic subtest A-DP1: SUCCESS (0.903s)
[156.887500] Starting dynamic subtest: B-DP1
[157.712146] Dynamic subtest B-DP1: SUCCESS (0.832s)
[157.721171] Starting dynamic subtest: C-DP1
[158.542795] Dynamic subtest C-DP1: SUCCESS (0.829s)
[158.549602] Starting dynamic subtest: D-DP1
[159.377350] Dynamic subtest D-DP1: SUCCESS (0.834s)
[159.380693] Subtest basic-plain-flip: SUCCESS (3.408s)
[159.642296] [107/165] (845s left) kms_force_connector_basic (force-connector-state)
[159.712824] Starting subtest: force-connector-state
[159.946548] Subtest force-connector-state: SUCCESS (0.234s)
[160.281877] [108/165] (844s left) kms_force_connector_basic (force-edid)
[160.354310] Starting subtest: force-edid
[160.370652] Subtest force-edid: SUCCESS (0.016s)
[160.527477] [109/165] (844s left) kms_force_connector_basic (force-load-detect)
[160.584725] Starting subtest: force-load-detect
[160.586238] Subtest force-load-detect: SKIP (0.000s)
[160.694562] [110/165] (844s left) kms_force_connector_basic (prune-stale-modes)
[160.759447] Starting subtest: prune-stale-modes
[160.767113] Subtest prune-stale-modes: SKIP (0.008s)
[161.014594] [111/165] (843s left) kms_frontbuffer_tracking (basic)
[161.178242] Starting subtest: basic
[164.409680] Subtest basic: SUCCESS (3.232s)
[164.593977] [112/165] (840s left) kms_hdmi_inject (inject-audio)
[164.752576] Starting subtest: inject-audio
[164.850840] Subtest inject-audio: SUCCESS (0.098s)
[165.131311] [113/165] (839s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[165.233630] Starting subtest: compare-crc-sanitycheck-xr24
[165.234508] Starting dynamic subtest: pipe-A-DP-1
[165.772872] Dynamic subtest pipe-A-DP-1: SUCCESS (0.538s)
[165.784105] Starting dynamic subtest: pipe-B-DP-1
[166.313829] Dynamic subtest pipe-B-DP-1: SUCCESS (0.538s)
[166.322733] Starting dynamic subtest: pipe-C-DP-1
[166.827918] Dynamic subtest pipe-C-DP-1: SUCCESS (0.513s)
[166.839777] Starting dynamic subtest: pipe-D-DP-1
[167.361811] Dynamic subtest pipe-D-DP-1: SUCCESS (0.531s)
[167.362804] Subtest compare-crc-sanitycheck-xr24: SUCCESS (2.129s)
[167.602365] [114/165] (837s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[167.703718] Starting subtest: compare-crc-sanitycheck-nv12
[167.704625] Starting dynamic subtest: pipe-A-DP-1
[168.975964] Dynamic subtest pipe-A-DP-1: SUCCESS (1.271s)
[168.987649] Starting dynamic subtest: pipe-B-DP-1
[170.201882] Dynamic subtest pipe-B-DP-1: SUCCESS (1.213s)
[170.210672] Starting dynamic subtest: pipe-C-DP-1
[171.333710] Dynamic subtest pipe-C-DP-1: SUCCESS (1.139s)
[171.341265] Starting dynamic subtest: pipe-D-DP-1
[172.504870] Dynamic subtest pipe-D-DP-1: SUCCESS (1.169s)
[172.505771] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.801s)
[172.769492] [115/165] (832s left) kms_pipe_crc_basic (hang-read-crc)
[172.884031] Starting subtest: hang-read-crc
[172.884916] Starting dynamic subtest: pipe-A-DP-1
[174.416763] Dynamic subtest pipe-A-DP-1: SUCCESS (1.533s)
[174.429061] Starting dynamic subtest: pipe-B-DP-1
[175.937857] Dynamic subtest pipe-B-DP-1: SUCCESS (1.518s)
[175.952587] Starting dynamic subtest: pipe-C-DP-1
[177.423605] Dynamic subtest pipe-C-DP-1: SUCCESS (1.483s)
[177.434199] Starting dynamic subtest: pipe-D-DP-1
[178.929110] Dynamic subtest pipe-D-DP-1: SUCCESS (1.503s)
[178.930174] Subtest hang-read-crc: SUCCESS (6.046s)
[179.156942] [116/165] (825s left) kms_pipe_crc_basic (nonblocking-crc)
[179.265382] Starting subtest: nonblocking-crc
[179.266393] Starting dynamic subtest: pipe-A-DP-1
[179.992781] Dynamic subtest pipe-A-DP-1: SUCCESS (0.726s)
[180.009258] Starting dynamic subtest: pipe-B-DP-1
[180.671670] Dynamic subtest pipe-B-DP-1: SUCCESS (0.676s)
[180.682918] Starting dynamic subtest: pipe-C-DP-1
[181.365460] Dynamic subtest pipe-C-DP-1: SUCCESS (0.691s)
[181.379864] Starting dynamic subtest: pipe-D-DP-1
[182.027852] Dynamic subtest pipe-D-DP-1: SUCCESS (0.659s)
[182.028999] Subtest nonblocking-crc: SUCCESS (2.762s)
[182.252389] [117/165] (822s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[182.377986] Starting subtest: nonblocking-crc-frame-sequence
[182.378894] Starting dynamic subtest: pipe-A-DP-1
[183.123956] Dynamic subtest pipe-A-DP-1: SUCCESS (0.745s)
[183.135187] Starting dynamic subtest: pipe-B-DP-1
[183.798066] Dynamic subtest pipe-B-DP-1: SUCCESS (0.673s)
[183.811175] Starting dynamic subtest: pipe-C-DP-1
[184.509089] Dynamic subtest pipe-C-DP-1: SUCCESS (0.707s)
[184.523865] Starting dynamic subtest: pipe-D-DP-1
[185.198242] Dynamic subtest pipe-D-DP-1: SUCCESS (0.685s)
[185.199237] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.821s)
[185.436534] [118/165] (819s left) kms_pipe_crc_basic (read-crc)
[185.558449] Starting subtest: read-crc
[185.559362] Starting dynamic subtest: pipe-A-DP-1
[186.208248] Dynamic subtest pipe-A-DP-1: SUCCESS (0.648s)
[186.223131] Starting dynamic subtest: pipe-B-DP-1
[186.889032] Dynamic subtest pipe-B-DP-1: SUCCESS (0.678s)
[186.895595] Starting dynamic subtest: pipe-C-DP-1
[187.525593] Dynamic subtest pipe-C-DP-1: SUCCESS (0.635s)
[187.538056] Starting dynamic subtest: pipe-D-DP-1
[188.201485] Dynamic subtest pipe-D-DP-1: SUCCESS (0.674s)
[188.202560] Subtest read-crc: SUCCESS (2.644s)
[188.434981] [119/165] (816s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[188.549422] Starting subtest: read-crc-frame-sequence
[188.550401] Starting dynamic subtest: pipe-A-DP-1
[189.207966] Dynamic subtest pipe-A-DP-1: SUCCESS (0.658s)
[189.223615] Starting dynamic subtest: pipe-B-DP-1
[189.824134] Dynamic subtest pipe-B-DP-1: SUCCESS (0.613s)
[189.839625] Starting dynamic subtest: pipe-C-DP-1
[190.425537] Dynamic subtest pipe-C-DP-1: SUCCESS (0.598s)
[190.439318] Starting dynamic subtest: pipe-D-DP-1
[191.091898] Dynamic subtest pipe-D-DP-1: SUCCESS (0.665s)
[191.092891] Subtest read-crc-frame-sequence: SUCCESS (2.544s)
[191.337271] [120/165] (813s left) kms_pm_backlight (basic-brightness)
[191.463892] Subtest basic-brightness: SKIP (0.000s)
[191.494314] [121/165] (813s left) kms_pm_rpm (basic-pci-d3-state)
[193.577066] Starting subtest: basic-pci-d3-state
[194.169596] Subtest basic-pci-d3-state: SUCCESS (0.592s)
[194.355191] [122/165] (810s left) kms_pm_rpm (basic-rte)
[194.438131] Starting subtest: basic-rte
[197.163199] Subtest basic-rte: SUCCESS (2.723s)
[197.752752] [123/165] (807s left) kms_psr (psr-primary-page-flip)
[197.880504] Subtest psr-primary-page-flip: SKIP (0.000s)
[197.908869] [124/165] (807s left) kms_psr (psr-cursor-plane-move)
[198.008206] Subtest psr-cursor-plane-move: SKIP (0.000s)
[198.042595] [125/165] (807s left) kms_psr (psr-sprite-plane-onoff)
[198.135094] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[198.159290] [126/165] (807s left) kms_psr (psr-primary-mmap-gtt)
[198.252881] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[198.276175] [127/165] (806s left) kms_setmode (basic-clone-single-crtc)
[198.337284] Starting subtest: basic-clone-single-crtc
[198.340577] Subtest basic-clone-single-crtc: SKIP (0.000s)
[198.411784] [128/165] (806s left) i915_pm_rps (basic-api)
[198.498427] Starting subtest: basic-api
[198.500202] Subtest basic-api: SKIP (0.000s)
[198.607852] [129/165] (806s left) prime_self_import (basic-llseek-bad)
[198.660887] Starting subtest: basic-llseek-bad
[198.670369] Subtest basic-llseek-bad: SUCCESS (0.009s)
[198.764268] [130/165] (806s left) prime_self_import (basic-llseek-size)
[198.812265] Starting subtest: basic-llseek-size
[198.833451] Subtest basic-llseek-size: SUCCESS (0.021s)
[198.952722] [131/165] (806s left) prime_self_import (basic-with_fd_dup)
[199.033383] Starting subtest: basic-with_fd_dup
[199.047565] Subtest basic-with_fd_dup: SUCCESS (0.014s)
[199.130764] [132/165] (806s left) prime_self_import (basic-with_one_bo)
[199.180243] Starting subtest: basic-with_one_bo
[199.192671] Subtest basic-with_one_bo: SUCCESS (0.012s)
[199.263811] [133/165] (806s left) prime_self_import (basic-with_one_bo_two_files)
[199.313062] Starting subtest: basic-with_one_bo_two_files
[199.326342] Subtest basic-with_one_bo_two_files: SUCCESS (0.014s)
[199.438428] [134/165] (805s left) prime_self_import (basic-with_two_bos)
[199.507302] Starting subtest: basic-with_two_bos
[199.528487] Subtest basic-with_two_bos: SUCCESS (0.021s)
[199.666943] [135/165] (805s left) prime_vgem (basic-fence-flip)
[199.777487] Starting subtest: basic-fence-flip
[199.844533] Subtest basic-fence-flip: SKIP (0.066s)
[199.940273] [136/165] (805s left) prime_vgem (basic-fence-mmap)
[200.017182] Starting subtest: basic-fence-mmap
[200.019092] Subtest basic-fence-mmap: SKIP (0.000s)
[200.136277] [137/165] (805s left) prime_vgem (basic-fence-read)
[200.215699] Starting subtest: basic-fence-read
[200.220912] Subtest basic-fence-read: SKIP (0.004s)
[200.338817] [138/165] (805s left) prime_vgem (basic-gtt)
[200.442132] Starting subtest: basic-gtt
[200.443738] Subtest basic-gtt: SKIP (0.000s)
[200.571796] [139/165] (804s left) prime_vgem (basic-read)
[200.657024] Starting subtest: basic-read
[200.662128] Subtest basic-read: SKIP (0.004s)
[200.789584] [140/165] (804s left) prime_vgem (basic-write)
[200.883408] Starting subtest: basic-write
[200.888546] Subtest basic-write: SKIP (0.004s)
[201.002292] [141/165] (804s left) vgem_basic (setversion)
[201.084067] Starting subtest: setversion
[201.085745] Subtest setversion: SUCCESS (0.000s)
[201.136715] [142/165] (804s left) vgem_basic (create)
[201.201139] Starting subtest: create
[201.201982] Subtest create: SUCCESS (0.000s)
[201.256657] [143/165] (804s left) vgem_basic (debugfs)
[201.317526] Starting subtest: debugfs
[201.318632] Subtest debugfs: SUCCESS (0.000s)
[201.375466] [144/165] (804s left) vgem_basic (dmabuf-export)
[201.484322] Starting subtest: dmabuf-export
[201.519399] Subtest dmabuf-export: SUCCESS (0.035s)
[201.633507] [145/165] (804s left) vgem_basic (dmabuf-fence)
[201.683982] Starting subtest: dmabuf-fence
[201.684835] Subtest dmabuf-fence: SUCCESS (0.000s)
[201.737674] [146/165] (803s left) vgem_basic (dmabuf-fence-before)
[201.801058] Starting subtest: dmabuf-fence-before
[201.801945] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[201.856542] [147/165] (803s left) vgem_basic (dmabuf-mmap)
[201.917330] Starting subtest: dmabuf-mmap
[201.925919] Subtest dmabuf-mmap: SUCCESS (0.009s)
[201.969955] [148/165] (803s left) vgem_basic (mmap)
[202.017406] Starting subtest: mmap
[202.022484] Subtest mmap: SUCCESS (0.005s)
[202.072825] [149/165] (803s left) vgem_basic (second-client)
[202.134228] Starting subtest: second-client
[202.167886] Subtest second-client: SUCCESS (0.033s)
[202.228515] [150/165] (803s left) vgem_basic (sysfs)
[202.300991] Starting subtest: sysfs
[202.302249] Subtest sysfs: SUCCESS (0.000s)
[202.357195] [151/165] (803s left) core_hotunplug (unbind-rebind)
[202.450545] Starting subtest: unbind-rebind
[212.139988] Subtest unbind-rebind: SUCCESS (9.689s)
[212.155893] [152/165] (793s left) vgem_basic (unload)
[212.203017] Starting subtest: unload
[241.128066] Subtest unload: SUCCESS (28.923s)
[241.237763] [153/165] (764s left) i915_module_load (reload)
[241.282741] Starting subtest: reload
[249.749594] Subtest reload: SUCCESS (8.467s)
[249.762803] [154/165] (756s left) gem_lmem_swapping (basic)
[258.314140] Starting subtest: basic
[258.315132] Starting dynamic subtest: lmem0
[275.647430] Dynamic subtest lmem0: SUCCESS (17.333s)
[275.648300] Subtest basic: SUCCESS (17.333s)
[277.960100] [155/165] (727s left) gem_lmem_swapping (parallel-random-engines)
[284.380704] Starting subtest: parallel-random-engines
[284.384288] Starting dynamic subtest: lmem0
[319.596334] Dynamic subtest lmem0: SUCCESS (35.217s)
[319.597353] Subtest parallel-random-engines: SUCCESS (35.218s)
[320.867738] [156/165] (684s left) gem_lmem_swapping (random-engines)
[327.262352] Starting subtest: random-engines
[327.263206] Starting dynamic subtest: lmem0
[328.021660] Dynamic subtest lmem0: SUCCESS (0.766s)
[328.022494] Subtest random-engines: SUCCESS (0.767s)
[329.137332] [157/165] (676s left) gem_lmem_swapping (verify-random)
[335.577398] Starting subtest: verify-random
[335.578330] Starting dynamic subtest: lmem0
[343.748218] Dynamic subtest lmem0: SUCCESS (8.171s)
[343.749126] Subtest verify-random: SUCCESS (8.172s)
[344.964629] [158/165] (660s left) i915_pm_rpm (module-reload)
[353.806378] Starting subtest: module-reload
[374.578866] Subtest module-reload: SUCCESS (20.772s)
[374.594716] [159/165] (631s left) i915_selftest (live)
[374.638706] Starting subtest: live
[374.639641] Starting dynamic subtest: sanitycheck
[381.593022] Dynamic subtest sanitycheck: SUCCESS (6.954s)
[381.598851] Starting dynamic subtest: uncore
[388.573934] Dynamic subtest uncore: SUCCESS (6.980s)
[388.580533] Starting dynamic subtest: workarounds
[398.560072] Dynamic subtest workarounds: SUCCESS (9.985s)
[398.565874] Starting dynamic subtest: gt_engines
[406.585841] Dynamic subtest gt_engines: SUCCESS (8.022s)
[406.591865] Starting dynamic subtest: gt_timelines
[439.713127] Dynamic subtest gt_timelines: SUCCESS (33.129s)
[439.720135] Starting dynamic subtest: gt_contexts
[446.736891] Dynamic subtest gt_contexts: SUCCESS (7.023s)
[446.742798] Starting dynamic subtest: gt_lrc
[460.391217] Dynamic subtest gt_lrc: SUCCESS (13.653s)
[460.398390] Starting dynamic subtest: gt_mocs
[469.870126] Dynamic subtest gt_mocs: SUCCESS (9.478s)
[469.876825] Starting dynamic subtest: gt_pm
[477.780139] Dynamic subtest gt_pm: SUCCESS (7.909s)
[477.786728] Starting dynamic subtest: gt_heartbeat
[484.944962] Dynamic subtest gt_heartbeat: SUCCESS (7.164s)
[484.952012] Starting dynamic subtest: gt_tlb
[503.187034] Dynamic subtest gt_tlb: SUCCESS (18.241s)
[503.193276] Starting dynamic subtest: requests
[526.505051] Dynamic subtest requests: SUCCESS (23.317s)
[526.511762] Starting dynamic subtest: migrate
[536.774935] Dynamic subtest migrate: SUCCESS (10.269s)
[536.781460] Starting dynamic subtest: active
[543.734841] Dynamic subtest active: SUCCESS (6.959s)
[543.740517] Starting dynamic subtest: objects
[551.695989] Dynamic subtest objects: SUCCESS (7.957s)
[551.702540] Starting dynamic subtest: mman
[566.500718] Dynamic subtest mman: SUCCESS (14.801s)
[566.506443] Starting dynamic subtest: dmabuf
[573.475963] Dynamic subtest dmabuf: SUCCESS (6.980s)
[573.484461] Starting dynamic subtest: vma
[580.477911] Dynamic subtest vma: SUCCESS (6.998s)
[580.485495] Starting dynamic subtest: coherency
[589.800962] Dynamic subtest coherency: SUCCESS (9.324s)
[589.807472] Starting dynamic subtest: gtt
[604.662857] Dynamic subtest gtt: SUCCESS (14.861s)
[604.668421] Starting dynamic subtest: gem
[611.684952] Dynamic subtest gem: SUCCESS (7.021s)
[611.690994] Starting dynamic subtest: evict
[620.514022] Dynamic subtest evict: SUCCESS (8.828s)
[620.520589] Starting dynamic subtest: hugepages
[644.498137] Dynamic subtest hugepages: SUCCESS (23.983s)
[644.503692] Starting dynamic subtest: gem_contexts
[694.065159] Dynamic subtest gem_contexts: SUCCESS (49.566s)
[694.070997] Starting dynamic subtest: client
[701.061308] Dynamic subtest client: SUCCESS (6.995s)
[701.067301] Starting dynamic subtest: gem_migrate
[710.936124] Dynamic subtest gem_migrate: SUCCESS (9.874s)
[710.941688] Starting dynamic subtest: reset
[717.990695] Dynamic subtest reset: SUCCESS (7.050s)
[717.997548] Starting dynamic subtest: memory_region
[726.477253] Dynamic subtest memory_region: SUCCESS (8.489s)
[726.484190] Starting dynamic subtest: hangcheck
[776.678100] Dynamic subtest hangcheck: SUCCESS (50.197s)
[776.684382] Starting dynamic subtest: execlists
[783.646099] Dynamic subtest execlists: SUCCESS (6.970s)
[783.652168] Starting dynamic subtest: ring_submission
[790.639052] Dynamic subtest ring_submission: SUCCESS (6.992s)
[790.645392] Starting dynamic subtest: perf
[797.720310] Dynamic subtest perf: SUCCESS (7.080s)
[797.727189] Starting dynamic subtest: slpc
[812.558299] Dynamic subtest slpc: SUCCESS (14.837s)
[812.564878] Starting dynamic subtest: guc
[820.888922] Dynamic subtest guc: SUCCESS (8.330s)
[820.894881] Starting dynamic subtest: guc_multi_lrc
[827.881039] Dynamic subtest guc_multi_lrc: SUCCESS (6.991s)
[827.886618] Starting dynamic subtest: guc_hang
[835.594013] Dynamic subtest guc_hang: SUCCESS (7.712s)
[835.599964] Starting dynamic subtest: late_gt_pm
[842.644126] Dynamic subtest late_gt_pm: SUCCESS (7.049s)
[842.645064] Subtest live: SUCCESS (468.005s)
[842.905472] [160/165] (163s left) dmabuf (all-tests)
[842.976205] Starting subtest: all-tests
[842.977181] Starting dynamic subtest: sanitycheck
[843.039608] Dynamic subtest sanitycheck: SUCCESS (0.064s)
[843.047719] Starting dynamic subtest: dma_fence
[843.217579] Dynamic subtest dma_fence: SUCCESS (0.177s)
[843.226253] Starting dynamic subtest: dma_fence_chain
[853.633732] Dynamic subtest dma_fence_chain: SUCCESS (10.415s)
[853.641239] Starting dynamic subtest: dma_fence_unwrap
[853.703258] Dynamic subtest dma_fence_unwrap: SUCCESS (0.068s)
[853.720061] Starting dynamic subtest: dma_resv
[853.790783] Dynamic subtest dma_resv: SUCCESS (0.086s)
[853.792194] Subtest all-tests: SUCCESS (10.816s)
[853.805482] [161/165] (152s left) i915_suspend (basic-s2idle-without-i915)
[853.849526] Starting subtest: basic-s2idle-without-i915
[884.533156] Subtest basic-s2idle-without-i915: SUCCESS (15.893s)
[884.632761] [162/165] (136s left) i915_suspend (basic-s3-without-i915)
[884.712556] Starting subtest: basic-s3-without-i915
[912.230185] Subtest basic-s3-without-i915: SUCCESS (11.357s)
[912.335276] [163/165] (124s left) gem_exec_suspend (basic-s0)
[912.434441] Starting subtest: basic-S0
[912.435437] Starting dynamic subtest: smem
[933.997499] Dynamic subtest smem: SUCCESS (6.633s)
[934.005763] Starting dynamic subtest: lmem0
[954.986084] Dynamic subtest lmem0: SUCCESS (6.277s)
[954.986942] Subtest basic-S0: SUCCESS (12.912s)
[955.136528] [164/165] (111s left) gem_exec_suspend (basic-s3)
[955.217174] Starting subtest: basic-S3
[955.218048] Starting dynamic subtest: smem
[976.996916] Dynamic subtest smem: SUCCESS (6.319s)
[977.004540] Starting dynamic subtest: lmem0
[998.960832] Dynamic subtest lmem0: SUCCESS (6.222s)
[998.961735] Subtest basic-S3: SUCCESS (12.542s)
[999.172248] [165/165] ( 98s left) kms_pipe_crc_basic (suspend-read-crc)
[999.320235] Starting subtest: suspend-read-crc
[999.321138] Starting dynamic subtest: pipe-A-DP-1
[1019.709968] Dynamic subtest pipe-A-DP-1: SUCCESS (4.665s)
[1019.722515] Starting dynamic subtest: pipe-B-DP-1
[1040.676078] Dynamic subtest pipe-B-DP-1: SUCCESS (4.587s)
[1040.690086] Starting dynamic subtest: pipe-C-DP-1
[1061.721577] Dynamic subtest pipe-C-DP-1: SUCCESS (4.633s)
[1061.735749] Starting dynamic subtest: pipe-D-DP-1
[1082.688759] Dynamic subtest pipe-D-DP-1: SUCCESS (4.568s)
[1082.689851] Subtest suspend-read-crc: SUCCESS (18.462s)
[1082.903616] Closing watchdogs
Done.