[40.215174] Initializing watchdogs
[40.215239]   /dev/watchdog0
[40.220492] [001/171] (960s left) i915_module_load (load)
[40.271174] Starting subtest: load
[41.303446] Subtest load: SUCCESS (1.029s)
[41.342537] [002/171] (959s left) core_auth (basic-auth)
[41.489825] Starting subtest: basic-auth
[41.490750] Subtest basic-auth: SUCCESS (0.001s)
[41.508437] [003/171] (959s left) debugfs_test (read_all_entries)
[41.591883] Starting subtest: read_all_entries
[41.911950] Subtest read_all_entries: SUCCESS (0.320s)
[42.026895] [004/171] (958s left) debugfs_test (basic-hwmon)
[42.088221] Starting subtest: basic-hwmon
[42.090879] Subtest basic-hwmon: SUCCESS (0.003s)
[42.221968] [005/171] (958s left) fbdev (eof)
[42.912249] Subtest eof: SKIP (0.000s)
[42.920987] [006/171] (957s left) fbdev (info)
[42.983780] Subtest info: SKIP (0.000s)
[42.992496] [007/171] (957s left) fbdev (nullptr)
[43.055052] Subtest nullptr: SKIP (0.000s)
[43.063030] [008/171] (957s left) fbdev (read)
[43.125338] Subtest read: SKIP (0.000s)
[43.134091] [009/171] (957s left) fbdev (write)
[43.197143] Subtest write: SKIP (0.000s)
[43.205214] [010/171] (957s left) gem_basic (bad-close)
[43.260811] Starting subtest: bad-close
[43.262663] Subtest bad-close: SUCCESS (0.000s)
[43.270319] [011/171] (957s left) gem_basic (create-close)
[43.325330] Starting subtest: create-close
[43.327203] Subtest create-close: SUCCESS (0.000s)
[43.350055] [012/171] (957s left) gem_basic (create-fd-close)
[43.407237] Starting subtest: create-fd-close
[43.409216] Subtest create-fd-close: SUCCESS (0.000s)
[43.435144] [013/171] (957s left) gem_busy (busy@all-engines)
[43.508205] Starting subtest: busy
[43.509150] Starting dynamic subtest: all-engines
[43.604317] Dynamic subtest all-engines: SUCCESS (0.096s)
[43.605143] Subtest busy: SUCCESS (0.096s)
[43.952266] [014/171] (956s left) gem_close_race (basic-process)
[44.084535] Starting subtest: basic-process
[44.132484] Subtest basic-process: SUCCESS (0.048s)
[44.288727] [015/171] (956s left) gem_close_race (basic-threads)
[44.383187] Starting subtest: basic-threads
[45.572469] Subtest basic-threads: SUCCESS (1.189s)
[45.751176] [016/171] (955s left) gem_ctx_create (basic)
[45.866762] Starting subtest: basic
[45.867955] Subtest basic: SUCCESS (0.000s)
[45.982562] [017/171] (955s left) gem_ctx_create (basic-files)
[46.048124] Starting subtest: basic-files
[48.124060] Subtest basic-files: SUCCESS (2.073s)
[48.520279] [018/171] (952s left) gem_ctx_exec (basic)
[48.618578] Starting subtest: basic
[48.622604] Subtest basic: SUCCESS (0.004s)
[48.663215] [019/171] (952s left) gem_exec_basic (basic)
[48.723248] Starting subtest: basic
[48.724189] Starting dynamic subtest: rcs0-smem
[48.725851] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[48.730484] Starting dynamic subtest: bcs0-smem
[48.731368] Dynamic subtest bcs0-smem: SUCCESS (0.000s)
[48.735702] Starting dynamic subtest: vcs0-smem
[48.736731] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[48.741137] Starting dynamic subtest: vcs1-smem
[48.742058] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[48.746590] Starting dynamic subtest: vecs0-smem
[48.747654] Dynamic subtest vecs0-smem: SUCCESS (0.000s)
[48.752163] Starting dynamic subtest: vecs1-smem
[48.753234] Dynamic subtest vecs1-smem: SUCCESS (0.001s)
[48.757641] Starting dynamic subtest: ccs0-smem
[48.758762] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[48.763115] Starting dynamic subtest: ccs1-smem
[48.764213] Dynamic subtest ccs1-smem: SUCCESS (0.001s)
[48.768640] Starting dynamic subtest: ccs2-smem
[48.769766] Dynamic subtest ccs2-smem: SUCCESS (0.001s)
[48.774214] Starting dynamic subtest: ccs3-smem
[48.775296] Dynamic subtest ccs3-smem: SUCCESS (0.001s)
[48.779639] Starting dynamic subtest: rcs0-lmem0
[48.780850] Dynamic subtest rcs0-lmem0: SUCCESS (0.001s)
[48.785210] Starting dynamic subtest: bcs0-lmem0
[48.786441] Dynamic subtest bcs0-lmem0: SUCCESS (0.000s)
[48.790937] Starting dynamic subtest: vcs0-lmem0
[48.792141] Dynamic subtest vcs0-lmem0: SUCCESS (0.000s)
[48.796640] Starting dynamic subtest: vcs1-lmem0
[48.797754] Dynamic subtest vcs1-lmem0: SUCCESS (0.000s)
[48.802203] Starting dynamic subtest: vecs0-lmem0
[48.803362] Dynamic subtest vecs0-lmem0: SUCCESS (0.000s)
[48.807421] Starting dynamic subtest: vecs1-lmem0
[48.808356] Dynamic subtest vecs1-lmem0: SUCCESS (0.000s)
[48.812809] Starting dynamic subtest: ccs0-lmem0
[48.813970] Dynamic subtest ccs0-lmem0: SUCCESS (0.000s)
[48.818049] Starting dynamic subtest: ccs1-lmem0
[48.818825] Dynamic subtest ccs1-lmem0: SUCCESS (0.000s)
[48.823331] Starting dynamic subtest: ccs2-lmem0
[48.824500] Dynamic subtest ccs2-lmem0: SUCCESS (0.000s)
[48.828947] Starting dynamic subtest: ccs3-lmem0
[48.830140] Dynamic subtest ccs3-lmem0: SUCCESS (0.000s)
[48.831332] Subtest basic: SUCCESS (0.013s)
[48.857895] [020/171] (952s left) gem_exec_create (basic)
[48.923558] Starting subtest: basic
[48.924484] Starting dynamic subtest: smem
[51.020849] Dynamic subtest smem: SUCCESS (2.097s)
[51.025544] Starting dynamic subtest: lmem0
[53.129327] Dynamic subtest lmem0: SUCCESS (2.108s)
[53.130381] Subtest basic: SUCCESS (4.206s)
[53.256573] [021/171] (947s left) gem_exec_fence (basic-busy)
[53.440916] Starting subtest: basic-busy
[53.441831] Starting dynamic subtest: rcs0
[53.521685] Dynamic subtest rcs0: SUCCESS (0.081s)
[53.527147] Starting dynamic subtest: bcs0
[53.573108] Dynamic subtest bcs0: SUCCESS (0.050s)
[53.581226] Starting dynamic subtest: vcs0
[53.623431] Dynamic subtest vcs0: SUCCESS (0.051s)
[53.632602] Starting dynamic subtest: vcs1
[53.674359] Dynamic subtest vcs1: SUCCESS (0.050s)
[53.693261] Starting dynamic subtest: vecs0
[53.728784] Dynamic subtest vecs0: SUCCESS (0.054s)
[53.747720] Starting dynamic subtest: vecs1
[53.782111] Dynamic subtest vecs1: SUCCESS (0.053s)
[53.801213] Starting dynamic subtest: ccs0
[53.836108] Dynamic subtest ccs0: SUCCESS (0.054s)
[53.855040] Starting dynamic subtest: ccs1
[53.894398] Dynamic subtest ccs1: SUCCESS (0.058s)
[53.913437] Starting dynamic subtest: ccs2
[53.952235] Dynamic subtest ccs2: SUCCESS (0.058s)
[53.971218] Starting dynamic subtest: ccs3
[54.009263] Dynamic subtest ccs3: SUCCESS (0.057s)
[54.011143] Subtest basic-busy: SUCCESS (0.567s)
[55.111646] [022/171] (945s left) gem_exec_fence (basic-wait)
[55.304776] Starting subtest: basic-wait
[55.306485] Starting dynamic subtest: rcs0
[55.423925] Dynamic subtest rcs0: SUCCESS (0.119s)
[55.432069] Starting dynamic subtest: bcs0
[55.472844] Dynamic subtest bcs0: SUCCESS (0.049s)
[55.483493] Starting dynamic subtest: vcs0
[55.525067] Dynamic subtest vcs0: SUCCESS (0.051s)
[55.545068] Starting dynamic subtest: vcs1
[55.579067] Dynamic subtest vcs1: SUCCESS (0.054s)
[55.587684] Starting dynamic subtest: vecs0
[55.626672] Dynamic subtest vecs0: SUCCESS (0.048s)
[55.633267] Starting dynamic subtest: vecs1
[55.677072] Dynamic subtest vecs1: SUCCESS (0.049s)
[55.695910] Starting dynamic subtest: ccs0
[55.737149] Dynamic subtest ccs0: SUCCESS (0.060s)
[55.756624] Starting dynamic subtest: ccs1
[55.805074] Dynamic subtest ccs1: SUCCESS (0.068s)
[55.824534] Starting dynamic subtest: ccs2
[55.861373] Dynamic subtest ccs2: SUCCESS (0.056s)
[55.880921] Starting dynamic subtest: ccs3
[55.916245] Dynamic subtest ccs3: SUCCESS (0.054s)
[55.918268] Subtest basic-wait: SUCCESS (0.611s)
[57.002326] [023/171] (944s left) gem_exec_fence (basic-await)
[57.206223] Starting subtest: basic-await
[57.208194] Starting dynamic subtest: rcs0
[57.323511] Dynamic subtest rcs0: SUCCESS (0.118s)
[57.328190] Starting dynamic subtest: bcs0
[57.416779] Dynamic subtest bcs0: SUCCESS (0.093s)
[57.422198] Starting dynamic subtest: vcs0
[57.515921] Dynamic subtest vcs0: SUCCESS (0.099s)
[57.521687] Starting dynamic subtest: vcs1
[57.614967] Dynamic subtest vcs1: SUCCESS (0.099s)
[57.620138] Starting dynamic subtest: vecs0
[57.711101] Dynamic subtest vecs0: SUCCESS (0.096s)
[57.716577] Starting dynamic subtest: vecs1
[57.807724] Dynamic subtest vecs1: SUCCESS (0.097s)
[57.812717] Starting dynamic subtest: ccs0
[57.902525] Dynamic subtest ccs0: SUCCESS (0.095s)
[57.907945] Starting dynamic subtest: ccs1
[58.000232] Dynamic subtest ccs1: SUCCESS (0.098s)
[58.005750] Starting dynamic subtest: ccs2
[58.099269] Dynamic subtest ccs2: SUCCESS (0.099s)
[58.104633] Starting dynamic subtest: ccs3
[58.196023] Dynamic subtest ccs3: SUCCESS (0.096s)
[58.197142] Subtest basic-await: SUCCESS (0.990s)
[59.302729] [024/171] (941s left) gem_exec_fence (nb-await)
[59.492078] Starting subtest: nb-await
[59.493594] Starting dynamic subtest: rcs0
[59.583662] Dynamic subtest rcs0: SUCCESS (0.092s)
[59.589156] Starting dynamic subtest: bcs0
[59.651562] Dynamic subtest bcs0: SUCCESS (0.067s)
[59.660882] Starting dynamic subtest: vcs0
[59.720993] Dynamic subtest vcs0: SUCCESS (0.070s)
[59.728898] Starting dynamic subtest: vcs1
[59.792453] Dynamic subtest vcs1: SUCCESS (0.071s)
[59.813932] Starting dynamic subtest: vecs0
[59.886152] Dynamic subtest vecs0: SUCCESS (0.094s)
[59.891509] Starting dynamic subtest: vecs1
[59.950308] Dynamic subtest vecs1: SUCCESS (0.064s)
[59.956723] Starting dynamic subtest: ccs0
[60.016079] Dynamic subtest ccs0: SUCCESS (0.065s)
[60.023917] Starting dynamic subtest: ccs1
[60.082464] Dynamic subtest ccs1: SUCCESS (0.066s)
[60.089056] Starting dynamic subtest: ccs2
[60.151608] Dynamic subtest ccs2: SUCCESS (0.068s)
[60.156023] Starting dynamic subtest: ccs3
[60.214592] Dynamic subtest ccs3: SUCCESS (0.063s)
[60.215821] Subtest nb-await: SUCCESS (0.723s)
[61.281576] [025/171] (939s left) gem_exec_gttfill (basic)
[61.353592] Starting subtest: basic
[66.565570] Subtest basic: SUCCESS (5.203s)
[66.742777] [026/171] (934s left) gem_exec_parallel (engines)
[66.852906] Starting subtest: engines
[66.853763] Starting dynamic subtest: basic
[68.670391] Dynamic subtest basic: SUCCESS (1.817s)
[68.675749] Starting dynamic subtest: contexts
[72.491442] Dynamic subtest contexts: SUCCESS (3.821s)
[72.496768] Starting dynamic subtest: fds
[76.372068] Dynamic subtest fds: SUCCESS (3.872s)
[76.389663] Starting dynamic subtest: userptr
[77.960197] Dynamic subtest userptr: SUCCESS (1.597s)
[77.961072] Subtest engines: SUCCESS (11.107s)
[78.169100] [027/171] (922s left) gem_exec_store (basic)
[78.262259] Starting subtest: basic
[78.412773] Subtest basic: SUCCESS (0.150s)
[78.578457] [028/171] (922s left) gem_flink_basic (bad-flink)
[78.657143] Starting subtest: bad-flink
[78.658007] Subtest bad-flink: SUCCESS (0.000s)
[78.667257] [029/171] (922s left) gem_flink_basic (bad-open)
[78.724686] Starting subtest: bad-open
[78.725521] Subtest bad-open: SUCCESS (0.000s)
[78.734905] [030/171] (922s left) gem_flink_basic (basic)
[78.793735] Starting subtest: basic
[78.794662] Subtest basic: SUCCESS (0.000s)
[78.815643] [031/171] (922s left) gem_flink_basic (double-flink)
[78.874894] Starting subtest: double-flink
[78.875789] Subtest double-flink: SUCCESS (0.000s)
[78.902641] [032/171] (922s left) gem_flink_basic (flink-lifetime)
[78.963806] Starting subtest: flink-lifetime
[78.964759] Subtest flink-lifetime: SUCCESS (0.001s)
[78.992794] [033/171] (922s left) gem_huc_copy (huc-copy)
[79.085251] Starting subtest: huc-copy
[79.090323] Subtest huc-copy: SUCCESS (0.005s)
[79.174601] [034/171] (922s left) gem_linear_blits (basic)
[79.313847] Starting subtest: basic
[79.335248] Subtest basic: SUCCESS (0.021s)
[79.408585] [035/171] (921s left) gem_mmap (basic)
[79.519176] Subtest basic: SKIP (0.000s)
[79.529258] [036/171] (921s left) gem_mmap_gtt (basic)
[79.588836] Subtest basic: SKIP (0.000s)
[79.598477] [037/171] (921s left) gem_render_linear_blits (basic)
[79.662126] Starting subtest: basic
[79.719513] Subtest basic: SUCCESS (0.057s)
[79.765718] [038/171] (921s left) gem_render_tiled_blits (basic)
[79.841987] Subtest basic: SKIP (0.000s)
[79.852089] [039/171] (921s left) gem_ringfill (basic-all)
[80.276404] Starting subtest: basic-all
[83.052268] Subtest basic-all: SUCCESS (2.768s)
[83.090322] [040/171] (918s left) gem_softpin (allocator-basic)
[83.154484] Starting subtest: allocator-basic
[83.320953] Subtest allocator-basic: SUCCESS (0.158s)
[83.368519] [041/171] (917s left) gem_softpin (allocator-basic-reserve)
[83.437919] Starting subtest: allocator-basic-reserve
[83.605090] Subtest allocator-basic-reserve: SUCCESS (0.159s)
[83.654538] [042/171] (917s left) gem_softpin (safe-alignment)
[83.724241] Starting subtest: safe-alignment
[83.775889] Subtest safe-alignment: SUCCESS (0.051s)
[83.832095] [043/171] (917s left) gem_sync (basic-all)
[83.930571] Starting subtest: basic-all
[86.035444] Subtest basic-all: SUCCESS (2.110s)
[86.159717] [044/171] (915s left) gem_sync (basic-each)
[86.243226] Starting subtest: basic-each
[89.143449] Subtest basic-each: SUCCESS (2.901s)
[89.290937] [045/171] (912s left) gem_tiled_blits (basic)
[89.353949] Subtest basic: SKIP (0.000s)
[89.363740] [046/171] (912s left) gem_tiled_fence_blits (basic)
[89.426273] Subtest basic: SKIP (0.000s)
[89.436311] [047/171] (912s left) gem_tiled_pread_basic
[89.504470] [048/171] (911s left) gem_wait (busy@all-engines)
[89.573945] Starting subtest: busy
[89.574819] Starting dynamic subtest: all-engines
[90.145212] Dynamic subtest all-engines: SUCCESS (0.571s)
[90.146172] Subtest busy: SUCCESS (0.571s)
[90.338754] [049/171] (911s left) gem_wait (wait@all-engines)
[90.414150] Starting subtest: wait
[90.414991] Starting dynamic subtest: all-engines
[91.500098] Dynamic subtest all-engines: SUCCESS (1.086s)
[91.501058] Subtest wait: SUCCESS (1.086s)
[91.687462] [050/171] (909s left) i915_getparams_basic (basic-eu-total)
[91.747563] Starting subtest: basic-eu-total
[91.749351] Subtest basic-eu-total: SUCCESS (0.000s)
[91.758441] [051/171] (909s left) i915_getparams_basic (basic-subslice-total)
[91.816595] Starting subtest: basic-subslice-total
[91.818455] Subtest basic-subslice-total: SUCCESS (0.000s)
[91.827340] [052/171] (909s left) i915_hangman (error-state-basic)
[91.899803] Starting subtest: error-state-basic
[92.079844] Subtest error-state-basic: SUCCESS (0.181s)
[92.100423] [053/171] (909s left) i915_pciid
[92.169657] [054/171] (909s left) kms_addfb_basic (addfb25-bad-modifier)
[92.229924] Starting subtest: addfb25-bad-modifier
[92.230839] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[92.380296] [055/171] (909s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[92.439660] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[92.580782] [056/171] (908s left) kms_addfb_basic (addfb25-modifier-no-flag)
[92.640238] Starting subtest: addfb25-modifier-no-flag
[92.641120] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[92.780881] [057/171] (908s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[92.840946] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[92.984417] [058/171] (908s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[93.043662] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[93.185213] [059/171] (908s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[93.363810] Starting subtest: addfb25-yf-tiled-legacy
[93.364624] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[93.386333] [060/171] (908s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[93.564792] Starting subtest: addfb25-y-tiled-legacy
[93.565625] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[93.591411] [061/171] (908s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[93.769005] Starting subtest: addfb25-y-tiled-small-legacy
[93.770532] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[93.794456] [062/171] (907s left) kms_addfb_basic (bad-pitch-0)
[93.853651] Starting subtest: bad-pitch-0
[93.854564] Subtest bad-pitch-0: SUCCESS (0.000s)
[93.999717] [063/171] (907s left) kms_addfb_basic (bad-pitch-1024)
[94.058188] Starting subtest: bad-pitch-1024
[94.059479] Subtest bad-pitch-1024: SUCCESS (0.000s)
[94.218089] [064/171] (907s left) kms_addfb_basic (bad-pitch-128)
[94.276817] Starting subtest: bad-pitch-128
[94.277615] Subtest bad-pitch-128: SUCCESS (0.000s)
[94.426312] [065/171] (907s left) kms_addfb_basic (bad-pitch-256)
[94.485700] Starting subtest: bad-pitch-256
[94.486543] Subtest bad-pitch-256: SUCCESS (0.000s)
[94.652372] [066/171] (907s left) kms_addfb_basic (bad-pitch-32)
[94.710557] Starting subtest: bad-pitch-32
[94.711396] Subtest bad-pitch-32: SUCCESS (0.000s)
[94.851752] [067/171] (906s left) kms_addfb_basic (bad-pitch-63)
[94.909703] Starting subtest: bad-pitch-63
[94.910636] Subtest bad-pitch-63: SUCCESS (0.000s)
[95.055298] [068/171] (906s left) kms_addfb_basic (bad-pitch-65536)
[95.114155] Starting subtest: bad-pitch-65536
[95.114986] Subtest bad-pitch-65536: SUCCESS (0.000s)
[95.262336] [069/171] (906s left) kms_addfb_basic (bad-pitch-999)
[95.320106] Starting subtest: bad-pitch-999
[95.321065] Subtest bad-pitch-999: SUCCESS (0.000s)
[95.463290] [070/171] (906s left) kms_addfb_basic (basic)
[95.521523] Starting subtest: basic
[95.522371] Subtest basic: SUCCESS (0.000s)
[95.677283] [071/171] (906s left) kms_addfb_basic (basic-x-tiled-legacy)
[95.736400] Starting subtest: basic-x-tiled-legacy
[95.737975] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[95.891179] [072/171] (905s left) kms_addfb_basic (basic-y-tiled-legacy)
[95.951592] Starting subtest: basic-y-tiled-legacy
[95.953240] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[96.106269] [073/171] (905s left) kms_addfb_basic (bo-too-small)
[96.284747] Starting subtest: bo-too-small
[96.285568] Subtest bo-too-small: SUCCESS (0.000s)
[96.309136] [074/171] (905s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[96.486898] Starting subtest: bo-too-small-due-to-tiling
[96.488477] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[96.508301] [075/171] (905s left) kms_addfb_basic (clobberred-modifier)
[96.566177] Starting subtest: clobberred-modifier
[96.567940] Subtest clobberred-modifier: SKIP (0.000s)
[96.724155] [076/171] (905s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[96.785013] Starting subtest: framebuffer-vs-set-tiling
[96.786771] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[96.938753] [077/171] (904s left) kms_addfb_basic (invalid-get-prop)
[96.997972] Starting subtest: invalid-get-prop
[96.998789] Subtest invalid-get-prop: SUCCESS (0.000s)
[97.150156] [078/171] (904s left) kms_addfb_basic (invalid-get-prop-any)
[97.209153] Starting subtest: invalid-get-prop-any
[97.210106] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[97.366014] [079/171] (904s left) kms_addfb_basic (invalid-set-prop)
[97.424582] Starting subtest: invalid-set-prop
[97.425409] Subtest invalid-set-prop: SUCCESS (0.000s)
[97.575287] [080/171] (904s left) kms_addfb_basic (invalid-set-prop-any)
[97.635061] Starting subtest: invalid-set-prop-any
[97.635908] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[97.781060] [081/171] (904s left) kms_addfb_basic (no-handle)
[97.839135] Starting subtest: no-handle
[97.840014] Subtest no-handle: SUCCESS (0.000s)
[97.983683] [082/171] (903s left) kms_addfb_basic (size-max)
[98.163938] Starting subtest: size-max
[98.164844] Subtest size-max: SUCCESS (0.000s)
[98.187470] [083/171] (903s left) kms_addfb_basic (small-bo)
[98.364807] Starting subtest: small-bo
[98.365635] Subtest small-bo: SUCCESS (0.000s)
[98.399779] [084/171] (903s left) kms_addfb_basic (tile-pitch-mismatch)
[98.467452] Starting subtest: tile-pitch-mismatch
[98.469291] Subtest tile-pitch-mismatch: SKIP (0.000s)
[98.612411] [085/171] (903s left) kms_addfb_basic (too-high)
[98.790009] Starting subtest: too-high
[98.790892] Subtest too-high: SUCCESS (0.000s)
[98.825972] [086/171] (903s left) kms_addfb_basic (too-wide)
[99.004963] Starting subtest: too-wide
[99.005809] Subtest too-wide: SUCCESS (0.000s)
[99.037155] [087/171] (902s left) kms_addfb_basic (unused-handle)
[99.094696] Starting subtest: unused-handle
[99.095618] Subtest unused-handle: SUCCESS (0.000s)
[99.236405] [088/171] (902s left) kms_addfb_basic (unused-modifier)
[99.295388] Starting subtest: unused-modifier
[99.296322] Subtest unused-modifier: SUCCESS (0.000s)
[99.438351] [089/171] (902s left) kms_addfb_basic (unused-offsets)
[99.496394] Starting subtest: unused-offsets
[99.497233] Subtest unused-offsets: SUCCESS (0.000s)
[99.638419] [090/171] (902s left) kms_addfb_basic (unused-pitches)
[99.696880] Starting subtest: unused-pitches
[99.697652] Subtest unused-pitches: SUCCESS (0.000s)
[99.846299] [091/171] (902s left) kms_busy (basic)
[100.030844] Subtest basic: SKIP (0.000s)
[100.042130] [092/171] (901s left) kms_chamelium_hpd (dp-hpd-fast)
[100.224498] Subtest dp-hpd-fast: SKIP (0.000s)
[100.235286] [093/171] (901s left) kms_chamelium_edid (dp-edid-read)
[100.416853] Subtest dp-edid-read: SKIP (0.000s)
[100.427562] [094/171] (901s left) kms_chamelium_frames (dp-crc-fast)
[100.609532] Subtest dp-crc-fast: SKIP (0.000s)
[100.620275] [095/171] (901s left) kms_chamelium_hpd (hdmi-hpd-fast)
[100.800741] Subtest hdmi-hpd-fast: SKIP (0.000s)
[100.812296] [096/171] (901s left) kms_chamelium_edid (hdmi-edid-read)
[100.993571] Subtest hdmi-edid-read: SKIP (0.000s)
[101.004488] [097/171] (901s left) kms_chamelium_frames (hdmi-crc-fast)
[101.185924] Subtest hdmi-crc-fast: SKIP (0.000s)
[101.196278] [098/171] (900s left) kms_chamelium_hpd (vga-hpd-fast)
[101.377577] Subtest vga-hpd-fast: SKIP (0.000s)
[101.388563] [099/171] (900s left) kms_chamelium_edid (vga-edid-read)
[101.568635] Subtest vga-edid-read: SKIP (0.000s)
[101.579414] [100/171] (900s left) kms_prop_blob (basic)
[101.638071] Starting subtest: basic
[101.639034] Subtest basic: SUCCESS (0.000s)
[101.649579] [101/171] (900s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[101.830206] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[101.839294] [102/171] (900s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[102.022083] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[102.031285] [103/171] (900s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[102.214166] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s)
[102.223792] [104/171] (899s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[102.406195] Subtest basic-flip-after-cursor-legacy: SKIP (0.000s)
[102.415436] [105/171] (899s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[102.599125] Subtest basic-flip-after-cursor-varying-size: SKIP (0.000s)
[102.609250] [106/171] (899s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[102.793074] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s)
[102.802613] [107/171] (899s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[102.986568] Subtest basic-flip-before-cursor-legacy: SKIP (0.000s)
[102.996045] [108/171] (899s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[103.178940] Subtest basic-flip-before-cursor-varying-size: SKIP (0.000s)
[103.188629] [109/171] (898s left) kms_flip (basic-flip-vs-dpms)
[103.303603] Starting subtest: basic-flip-vs-dpms
[103.306758] Subtest basic-flip-vs-dpms: SKIP (0.003s)
[103.324215] [110/171] (898s left) kms_flip (basic-flip-vs-modeset)
[103.437584] Starting subtest: basic-flip-vs-modeset
[103.440988] Subtest basic-flip-vs-modeset: SKIP (0.003s)
[103.481191] [111/171] (898s left) kms_flip (basic-flip-vs-wf_vblank)
[103.594934] Starting subtest: basic-flip-vs-wf_vblank
[103.597901] Subtest basic-flip-vs-wf_vblank: SKIP (0.003s)
[103.629515] [112/171] (898s left) kms_flip (basic-plain-flip)
[103.742917] Starting subtest: basic-plain-flip
[103.746013] Subtest basic-plain-flip: SKIP (0.003s)
[103.780291] [113/171] (898s left) kms_force_connector_basic (force-connector-state)
[103.858969] Starting subtest: force-connector-state
[104.371923] Subtest force-connector-state: SUCCESS (0.513s)
[104.601505] [114/171] (897s left) kms_force_connector_basic (force-edid)
[104.678173] Starting subtest: force-edid
[104.705261] Subtest force-edid: SUCCESS (0.027s)
[104.863246] [115/171] (897s left) kms_force_connector_basic (force-load-detect)
[104.940130] Starting subtest: force-load-detect
[104.941920] Subtest force-load-detect: SKIP (0.000s)
[105.050678] [116/171] (897s left) kms_force_connector_basic (prune-stale-modes)
[105.126116] Starting subtest: prune-stale-modes
[105.142456] Subtest prune-stale-modes: SKIP (0.015s)
[105.297841] [117/171] (896s left) kms_frontbuffer_tracking (basic)
[105.476766] Subtest basic: SKIP (0.000s)
[105.509592] [118/171] (896s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[105.690059] Subtest compare-crc-sanitycheck-xr24: SKIP (0.000s)
[105.704870] [119/171] (896s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[105.882887] Subtest compare-crc-sanitycheck-nv12: SKIP (0.000s)
[105.898437] [120/171] (896s left) kms_pipe_crc_basic (hang-read-crc)
[106.079209] Subtest hang-read-crc: SKIP (0.000s)
[106.094690] [121/171] (896s left) kms_pipe_crc_basic (nonblocking-crc)
[106.274610] Subtest nonblocking-crc: SKIP (0.000s)
[106.290923] [122/171] (896s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[106.470939] Subtest nonblocking-crc-frame-sequence: SKIP (0.000s)
[106.486682] [123/171] (895s left) kms_pipe_crc_basic (read-crc)
[106.665546] Subtest read-crc: SKIP (0.000s)
[106.680275] [124/171] (895s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[106.858977] Subtest read-crc-frame-sequence: SKIP (0.000s)
[106.874122] [125/171] (895s left) kms_psr (primary_page_flip)
[106.934778] Subtest primary_page_flip: SKIP (0.000s)
[106.948427] [126/171] (895s left) kms_psr (cursor_plane_move)
[107.007744] Subtest cursor_plane_move: SKIP (0.000s)
[107.022139] [127/171] (895s left) kms_psr (sprite_plane_onoff)
[107.088581] Subtest sprite_plane_onoff: SKIP (0.000s)
[107.098066] [128/171] (895s left) kms_psr (primary_mmap_gtt)
[107.157291] Subtest primary_mmap_gtt: SKIP (0.000s)
[107.171990] [129/171] (895s left) kms_setmode (basic-clone-single-crtc)
[107.230387] Starting subtest: basic-clone-single-crtc
[107.232799] Subtest basic-clone-single-crtc: SKIP (0.000s)
[107.249545] [130/171] (895s left) i915_pm_backlight (basic-brightness)
[107.428028] Subtest basic-brightness: SKIP (0.000s)
[107.442953] [131/171] (895s left) i915_pm_rpm (basic-pci-d3-state)
[109.278538] Starting subtest: basic-pci-d3-state
[110.201322] Subtest basic-pci-d3-state: SUCCESS (0.923s)
[110.278684] [132/171] (892s left) i915_pm_rpm (basic-rte)
[110.336620] Starting subtest: basic-rte
[113.640048] Subtest basic-rte: SUCCESS (3.301s)
[114.598738] [133/171] (887s left) i915_pm_rps (basic-api)
[114.662392] Starting subtest: basic-api
[114.663994] Subtest basic-api: SKIP (0.000s)
[114.683304] [134/171] (887s left) prime_self_import (basic-llseek-bad)
[114.740184] Starting subtest: basic-llseek-bad
[114.741939] Subtest basic-llseek-bad: SUCCESS (0.002s)
[114.770667] [135/171] (887s left) prime_self_import (basic-llseek-size)
[114.827343] Starting subtest: basic-llseek-size
[114.830024] Subtest basic-llseek-size: SUCCESS (0.003s)
[114.869617] [136/171] (887s left) prime_self_import (basic-with_fd_dup)
[114.926531] Starting subtest: basic-with_fd_dup
[114.929290] Subtest basic-with_fd_dup: SUCCESS (0.003s)
[114.971541] [137/171] (887s left) prime_self_import (basic-with_one_bo)
[115.030436] Starting subtest: basic-with_one_bo
[115.033256] Subtest basic-with_one_bo: SUCCESS (0.003s)
[115.054970] [138/171] (887s left) prime_self_import (basic-with_one_bo_two_files)
[115.112284] Starting subtest: basic-with_one_bo_two_files
[115.115105] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s)
[115.157101] [139/171] (887s left) prime_self_import (basic-with_two_bos)
[115.213593] Starting subtest: basic-with_two_bos
[115.216211] Subtest basic-with_two_bos: SUCCESS (0.003s)
[115.285638] [140/171] (887s left) prime_vgem (basic-fence-flip)
[115.360908] Starting subtest: basic-fence-flip
[115.481928] Subtest basic-fence-flip: SKIP (0.120s)
[115.503884] [141/171] (887s left) prime_vgem (basic-fence-mmap)
[115.569659] Starting subtest: basic-fence-mmap
[115.571288] Subtest basic-fence-mmap: SKIP (0.000s)
[115.609774] [142/171] (886s left) prime_vgem (basic-fence-read)
[115.678233] Starting subtest: basic-fence-read
[115.684872] Subtest basic-fence-read: SKIP (0.006s)
[115.735262] [143/171] (886s left) prime_vgem (basic-gtt)
[115.802809] Starting subtest: basic-gtt
[115.804845] Subtest basic-gtt: SKIP (0.000s)
[115.841737] [144/171] (886s left) prime_vgem (basic-read)
[115.907463] Starting subtest: basic-read
[115.912235] Subtest basic-read: SKIP (0.004s)
[115.958149] [145/171] (886s left) prime_vgem (basic-write)
[116.029178] Starting subtest: basic-write
[116.033942] Subtest basic-write: SKIP (0.004s)
[116.080206] [146/171] (886s left) vgem_basic (setversion)
[116.142942] Starting subtest: setversion
[116.144627] Subtest setversion: SUCCESS (0.000s)
[116.159301] [147/171] (886s left) vgem_basic (create)
[116.219807] Starting subtest: create
[116.220617] Subtest create: SUCCESS (0.000s)
[116.236404] [148/171] (886s left) vgem_basic (debugfs)
[116.297266] Starting subtest: debugfs
[116.298177] Subtest debugfs: SUCCESS (0.000s)
[116.313528] [149/171] (886s left) vgem_basic (dmabuf-export)
[116.374504] Starting subtest: dmabuf-export
[116.376244] Subtest dmabuf-export: SUCCESS (0.002s)
[116.416310] [150/171] (886s left) vgem_basic (dmabuf-fence)
[116.477054] Starting subtest: dmabuf-fence
[116.477934] Subtest dmabuf-fence: SUCCESS (0.000s)
[116.493274] [151/171] (886s left) vgem_basic (dmabuf-fence-before)
[116.553568] Starting subtest: dmabuf-fence-before
[116.554467] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[116.570223] [152/171] (886s left) vgem_basic (dmabuf-mmap)
[116.631246] Starting subtest: dmabuf-mmap
[116.638586] Subtest dmabuf-mmap: SUCCESS (0.009s)
[116.656125] [153/171] (886s left) vgem_basic (mmap)
[116.716037] Starting subtest: mmap
[116.720328] Subtest mmap: SUCCESS (0.005s)
[116.737529] [154/171] (886s left) vgem_basic (second-client)
[116.798160] Starting subtest: second-client
[116.803816] Subtest second-client: SUCCESS (0.006s)
[116.820420] [155/171] (885s left) vgem_basic (sysfs)
[116.879532] Starting subtest: sysfs
[116.880451] Subtest sysfs: SUCCESS (0.000s)
[116.896035] [156/171] (885s left) core_hotunplug (unbind-rebind)
[116.979176] Starting subtest: unbind-rebind
[118.861439] Subtest unbind-rebind: SUCCESS (1.882s)
[118.878053] [157/171] (883s left) vgem_basic (unload)
[118.941172] Starting subtest: unload
[147.837153] Subtest unload: SUCCESS (28.861s)
[147.847702] [158/171] (854s left) i915_module_load (reload)
[147.913393] Starting subtest: reload
[150.517140] Subtest reload: SUCCESS (2.604s)
[150.528671] [159/171] (852s left) gem_lmem_swapping (basic)
[153.475339] Starting subtest: basic
[153.476190] Starting dynamic subtest: lmem0
[172.801969] Dynamic subtest lmem0: SUCCESS (19.317s)
[172.802939] Subtest basic: SUCCESS (19.317s)
[175.240431] [160/171] (827s left) gem_lmem_swapping (parallel-random-engines)
[175.744895] Starting subtest: parallel-random-engines
[175.745967] Starting dynamic subtest: lmem0
[176.553810] Dynamic subtest lmem0: SUCCESS (0.809s)
[176.554578] Subtest parallel-random-engines: SUCCESS (0.809s)
[177.794403] [161/171] (825s left) gem_lmem_swapping (random-engines)
[178.288924] Starting subtest: random-engines
[178.289667] Starting dynamic subtest: lmem0
[179.016065] Dynamic subtest lmem0: SUCCESS (0.718s)
[179.016910] Subtest random-engines: SUCCESS (0.719s)
[180.314665] [162/171] (822s left) gem_lmem_swapping (verify-random)
[180.859909] Starting subtest: verify-random
[180.860702] Starting dynamic subtest: lmem0
[188.193158] Dynamic subtest lmem0: SUCCESS (7.299s)
[188.194188] Subtest verify-random: SUCCESS (7.300s)
[189.458268] [163/171] (813s left) i915_pm_rpm (module-reload)
[191.569999] Starting subtest: module-reload
[200.848499] Subtest module-reload: SUCCESS (9.270s)
[200.870529] [164/171] (802s left) i915_selftest (live)
[200.925685] Starting subtest: live
[200.926644] Starting dynamic subtest: sanitycheck
[202.320286] Dynamic subtest sanitycheck: SUCCESS (1.386s)
[202.325487] Starting dynamic subtest: uncore
[203.738479] Dynamic subtest uncore: SUCCESS (1.417s)
[203.744478] Starting dynamic subtest: workarounds
[208.068251] Dynamic subtest workarounds: SUCCESS (4.329s)
[208.073475] Starting dynamic subtest: gt_engines
[210.542243] Dynamic subtest gt_engines: SUCCESS (2.473s)
[210.547498] Starting dynamic subtest: gt_timelines
[238.249286] Dynamic subtest gt_timelines: SUCCESS (27.706s)
[238.254948] Starting dynamic subtest: gt_contexts
[239.704371] Dynamic subtest gt_contexts: SUCCESS (1.455s)
[239.709262] Starting dynamic subtest: gt_lrc
[247.539755] Dynamic subtest gt_lrc: SUCCESS (7.834s)
[247.544449] Starting dynamic subtest: gt_mocs
[251.481355] Dynamic subtest gt_mocs: SUCCESS (3.941s)
[251.487264] Starting dynamic subtest: gt_pm
[253.814201] Dynamic subtest gt_pm: SUCCESS (2.332s)
[253.819246] Starting dynamic subtest: gt_heartbeat
[255.411260] Dynamic subtest gt_heartbeat: SUCCESS (1.596s)
[255.416924] Starting dynamic subtest: gt_tlb
[267.532397] Dynamic subtest gt_tlb: SUCCESS (12.120s)
[267.537282] Starting dynamic subtest: requests
[285.006359] Dynamic subtest requests: SUCCESS (17.473s)
[285.011671] Starting dynamic subtest: migrate
[289.453415] Dynamic subtest migrate: SUCCESS (4.446s)
[289.459575] Starting dynamic subtest: active
[290.852485] Dynamic subtest active: SUCCESS (1.398s)
[290.859119] Starting dynamic subtest: objects
[293.115264] Dynamic subtest objects: SUCCESS (2.262s)
[293.121244] Starting dynamic subtest: mman
[301.577576] Dynamic subtest mman: SUCCESS (8.464s)
[301.582390] Starting dynamic subtest: dmabuf
[302.979052] Dynamic subtest dmabuf: SUCCESS (1.403s)
[302.983928] Starting dynamic subtest: vma
[304.396975] Dynamic subtest vma: SUCCESS (1.412s)
[304.401827] Starting dynamic subtest: coherency
[307.253023] Dynamic subtest coherency: SUCCESS (2.855s)
[307.257760] Starting dynamic subtest: gtt
[315.999240] Dynamic subtest gtt: SUCCESS (8.745s)
[316.004553] Starting dynamic subtest: gem
[317.417191] Dynamic subtest gem: SUCCESS (1.417s)
[317.422590] Starting dynamic subtest: evict
[320.880407] Dynamic subtest evict: SUCCESS (3.462s)
[320.885702] Starting dynamic subtest: hugepages
[338.420330] Dynamic subtest hugepages: SUCCESS (17.539s)
[338.426439] Starting dynamic subtest: gem_contexts
[378.650214] Dynamic subtest gem_contexts: SUCCESS (40.203s)
[378.655050] Starting dynamic subtest: client
[380.046441] Dynamic subtest client: SUCCESS (1.421s)
[380.052553] Starting dynamic subtest: gem_migrate
[385.071609] Dynamic subtest gem_migrate: SUCCESS (5.024s)
[385.078683] Starting dynamic subtest: reset
[386.557363] Dynamic subtest reset: SUCCESS (1.485s)
[386.563785] Starting dynamic subtest: memory_region
[389.463287] Dynamic subtest memory_region: SUCCESS (2.905s)
[389.468663] Starting dynamic subtest: hangcheck
[434.729424] Dynamic subtest hangcheck: SUCCESS (45.265s)
[434.735655] Starting dynamic subtest: execlists
[436.151341] Dynamic subtest execlists: SUCCESS (1.421s)
[436.157058] Starting dynamic subtest: ring_submission
[437.565182] Dynamic subtest ring_submission: SUCCESS (1.413s)
[437.571205] Starting dynamic subtest: perf
[439.040050] Dynamic subtest perf: SUCCESS (1.474s)
[439.045362] Starting dynamic subtest: slpc
[448.191239] Dynamic subtest slpc: SUCCESS (9.150s)
[448.196915] Starting dynamic subtest: guc
[450.848208] Dynamic subtest guc: SUCCESS (2.656s)
[450.853503] Starting dynamic subtest: guc_multi_lrc
[452.284275] Dynamic subtest guc_multi_lrc: SUCCESS (1.435s)
[452.289106] Starting dynamic subtest: guc_hang
[454.413455] Dynamic subtest guc_hang: SUCCESS (2.128s)
[454.419257] Starting dynamic subtest: late_gt_pm
[455.865294] Dynamic subtest late_gt_pm: SUCCESS (1.451s)
[455.866428] Subtest live: SUCCESS (254.931s)
[456.309700] [165/171] (546s left) dmabuf (all-tests)
[456.392903] Starting subtest: all-tests
[456.394070] Starting dynamic subtest: sanitycheck
[456.451712] Dynamic subtest sanitycheck: SUCCESS (0.059s)
[456.458060] Starting dynamic subtest: dma_fence
[456.623569] Dynamic subtest dma_fence: SUCCESS (0.171s)
[456.632537] Starting dynamic subtest: dma_fence_chain
[467.120516] Dynamic subtest dma_fence_chain: SUCCESS (10.496s)
[467.128139] Starting dynamic subtest: dma_fence_unwrap
[467.184199] Dynamic subtest dma_fence_unwrap: SUCCESS (0.062s)
[467.196052] Starting dynamic subtest: dma_resv
[467.263182] Dynamic subtest dma_resv: SUCCESS (0.077s)
[467.264826] Subtest all-tests: SUCCESS (10.871s)
[467.304384] [166/171] (535s left) i915_suspend (basic-s2idle-without-i915)
[467.392869] Starting subtest: basic-s2idle-without-i915
[486.476558] Subtest basic-s2idle-without-i915: SUCCESS (4.687s)
[486.519044] [167/171] (530s left) i915_suspend (basic-s3-without-i915)
[486.582192] Starting subtest: basic-s3-without-i915
[508.148756] Subtest basic-s3-without-i915: SUCCESS (5.745s)
[508.181409] [168/171] (525s left) gem_exec_suspend (basic-s0)
[508.262713] Starting subtest: basic-S0
[508.263529] Starting dynamic subtest: smem
[528.205790] Dynamic subtest smem: SUCCESS (4.680s)
[528.220232] Starting dynamic subtest: lmem0
[548.252490] Dynamic subtest lmem0: SUCCESS (5.251s)
[548.253908] Subtest basic-S0: SUCCESS (9.935s)
[548.456123] [169/171] (514s left) gem_exec_suspend (basic-s3)
[548.551922] Starting subtest: basic-S3
[548.552898] Starting dynamic subtest: smem
[569.565048] Dynamic subtest smem: SUCCESS (5.667s)
[569.576314] Starting dynamic subtest: lmem0
[590.566232] Dynamic subtest lmem0: SUCCESS (5.163s)
[590.567460] Subtest basic-S3: SUCCESS (10.832s)
[590.728212] [170/171] (503s left) kms_chamelium_hpd (common-hpd-after-suspend)
[590.964102] Subtest common-hpd-after-suspend: SKIP (0.000s)
[590.976631] [171/171] (503s left) kms_pipe_crc_basic (suspend-read-crc)
[591.160010] Subtest suspend-read-crc: SKIP (0.000s)
[591.171188] Closing watchdogs
Done.