[38.210017] Initializing watchdogs
[38.210093]   /dev/watchdog0
[38.222870] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3e92 Intel Coffeelake (Gen9) CoffeeLake-S GT2 [UHD Graphics 630]
[38.228901] [001/161] (960s left) i915_module_load (load)
[38.284756] Starting subtest: load
[40.320482] Subtest load: SUCCESS (2.037s)
[40.353280] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[40.355098] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[40.359694] [002/161] (958s left) core_auth (basic-auth)
[40.434071] Starting subtest: basic-auth
[40.435603] Subtest basic-auth: SUCCESS (0.001s)
[40.501940] [003/161] (958s left) debugfs_test (read_all_entries)
[40.553410] Starting subtest: read_all_entries
[40.622072] Subtest read_all_entries: SUCCESS (0.068s)
[40.787521] [004/161] (958s left) debugfs_test (basic-hwmon)
[40.834832] Starting subtest: basic-hwmon
[40.837652] Subtest basic-hwmon: SKIP (0.000s)
[41.004712] [005/161] (957s left) debugfs_test (sysfs)
[41.052319] Starting subtest: sysfs
[41.096206] Subtest sysfs: SUCCESS (0.043s)
[41.252520] [006/161] (957s left) fbdev (eof)
[41.304787] Starting subtest: eof
[41.306380] Subtest eof: SUCCESS (0.000s)
[41.388840] [007/161] (957s left) fbdev (info)
[41.431113] Starting subtest: info
[41.432691] Subtest info: SUCCESS (0.000s)
[41.507237] [008/161] (957s left) fbdev (nullptr)
[41.553970] Starting subtest: nullptr
[41.555584] Subtest nullptr: SUCCESS (0.000s)
[41.619820] [009/161] (957s left) fbdev (read)
[41.671236] Starting subtest: read
[41.901891] Subtest read: SUCCESS (0.231s)
[41.968359] [010/161] (957s left) fbdev (write)
[42.020556] Starting subtest: write
[42.135713] Subtest write: SUCCESS (0.115s)
[42.199380] [011/161] (956s left) gem_basic (bad-close)
[42.239566] Starting subtest: bad-close
[42.242764] Subtest bad-close: SUCCESS (0.000s)
[42.330888] [012/161] (956s left) gem_basic (create-close)
[42.374235] Starting subtest: create-close
[42.377210] Subtest create-close: SUCCESS (0.000s)
[42.554919] [013/161] (956s left) gem_basic (create-fd-close)
[42.598135] Starting subtest: create-fd-close
[42.601224] Subtest create-fd-close: SUCCESS (0.000s)
[42.707395] [014/161] (956s left) gem_busy (busy@all-engines)
[42.763112] Starting subtest: busy
[42.764523] Starting dynamic subtest: all-engines
[42.793680] Dynamic subtest all-engines: SUCCESS (0.030s)
[42.795221] Subtest busy: SUCCESS (0.031s)
[43.191375] [015/161] (956s left) gem_close_race (basic-process)
[43.244056] Starting subtest: basic-process
[43.300981] Subtest basic-process: SUCCESS (0.057s)
[43.554447] [016/161] (955s left) gem_close_race (basic-threads)
[43.607480] Starting subtest: basic-threads
[44.825386] Subtest basic-threads: SUCCESS (1.218s)
[45.072120] [017/161] (954s left) gem_ctx_create (basic)
[45.125248] Starting subtest: basic
[45.126893] Subtest basic: SUCCESS (0.000s)
[45.337471] [018/161] (954s left) gem_ctx_create (basic-files)
[45.388052] Starting subtest: basic-files
[47.400244] Subtest basic-files: SUCCESS (2.012s)
[47.692306] [019/161] (951s left) gem_ctx_exec (basic)
[47.736975] Starting subtest: basic
[47.738759] Subtest basic: SUCCESS (0.003s)
[47.892091] [020/161] (951s left) gem_exec_basic (basic)
[47.938976] Starting subtest: basic
[47.940677] Starting dynamic subtest: rcs0-smem
[47.942269] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[47.949257] Starting dynamic subtest: bcs0-smem
[47.950893] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[47.957792] Starting dynamic subtest: vcs0-smem
[47.959204] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[47.966166] Starting dynamic subtest: vecs0-smem
[47.967812] Dynamic subtest vecs0-smem: SUCCESS (0.000s)
[47.969250] Subtest basic: SUCCESS (0.003s)
[48.221719] [021/161] (951s left) gem_exec_create (basic)
[48.271949] Starting subtest: basic
[48.273603] Starting dynamic subtest: smem
[50.339952] Dynamic subtest smem: SUCCESS (2.068s)
[50.341529] Subtest basic: SUCCESS (2.068s)
[50.519586] [022/161] (949s left) gem_exec_fence (basic-busy)
[50.685604] Starting subtest: basic-busy
[50.687119] Starting dynamic subtest: rcs0
[50.737358] Dynamic subtest rcs0: SUCCESS (0.051s)
[50.774332] Starting dynamic subtest: bcs0
[50.789805] Dynamic subtest bcs0: SUCCESS (0.052s)
[50.803744] Starting dynamic subtest: vcs0
[50.841729] Dynamic subtest vcs0: SUCCESS (0.052s)
[50.855172] Starting dynamic subtest: vecs0
[50.887086] Dynamic subtest vecs0: SUCCESS (0.045s)
[50.888945] Subtest basic-busy: SUCCESS (0.201s)
[51.509896] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[51.512210] [023/161] (948s left) gem_exec_fence (basic-wait)
[51.719496] Starting subtest: basic-wait
[51.721284] Starting dynamic subtest: rcs0
[51.753899] Dynamic subtest rcs0: SUCCESS (0.034s)
[51.763909] Starting dynamic subtest: bcs0
[51.791928] Dynamic subtest bcs0: SUCCESS (0.038s)
[51.803184] Starting dynamic subtest: vcs0
[51.828057] Dynamic subtest vcs0: SUCCESS (0.036s)
[51.850740] Starting dynamic subtest: vecs0
[51.870191] Dynamic subtest vecs0: SUCCESS (0.042s)
[51.872261] Subtest basic-wait: SUCCESS (0.151s)
[52.404015] [024/161] (947s left) gem_exec_fence (basic-await)
[52.578540] Starting subtest: basic-await
[52.580153] Starting dynamic subtest: rcs0
[52.666523] Dynamic subtest rcs0: SUCCESS (0.088s)
[52.674330] Starting dynamic subtest: bcs0
[52.742565] Dynamic subtest bcs0: SUCCESS (0.076s)
[52.750157] Starting dynamic subtest: vcs0
[52.819521] Dynamic subtest vcs0: SUCCESS (0.077s)
[52.827039] Starting dynamic subtest: vecs0
[52.896942] Dynamic subtest vecs0: SUCCESS (0.077s)
[52.898734] Subtest basic-await: SUCCESS (0.318s)
[53.529870] [025/161] (946s left) gem_exec_fence (nb-await)
[53.739287] Starting subtest: nb-await
[53.741241] Starting dynamic subtest: rcs0
[53.807373] Dynamic subtest rcs0: SUCCESS (0.068s)
[53.827639] Starting dynamic subtest: bcs0
[53.877044] Dynamic subtest bcs0: SUCCESS (0.069s)
[53.887224] Starting dynamic subtest: vcs0
[53.936509] Dynamic subtest vcs0: SUCCESS (0.059s)
[53.952970] Starting dynamic subtest: vecs0
[54.000768] Dynamic subtest vecs0: SUCCESS (0.063s)
[54.003744] Subtest nb-await: SUCCESS (0.261s)
[54.606864] [026/161] (945s left) gem_exec_gttfill (basic)
[54.659186] Starting subtest: basic
[59.969168] Subtest basic: SUCCESS (5.310s)
[60.156232] [027/161] (939s left) gem_exec_parallel (engines)
[60.252310] Starting subtest: engines
[60.253824] Starting dynamic subtest: basic
[62.026461] Dynamic subtest basic: SUCCESS (1.774s)
[62.034558] Starting dynamic subtest: contexts
[64.517188] Dynamic subtest contexts: SUCCESS (2.490s)
[64.525525] Starting dynamic subtest: fds
[66.568103] Dynamic subtest fds: SUCCESS (2.051s)
[66.577217] Starting dynamic subtest: userptr
[68.889655] Dynamic subtest userptr: SUCCESS (2.321s)
[68.891400] Subtest engines: SUCCESS (8.637s)
[69.147713] [028/161] (930s left) gem_exec_store (basic)
[69.200191] Starting subtest: basic
[69.269935] Subtest basic: SUCCESS (0.070s)
[69.487387] [029/161] (930s left) gem_flink_basic (bad-flink)
[69.529228] Starting subtest: bad-flink
[69.530694] Subtest bad-flink: SUCCESS (0.000s)
[69.625181] [030/161] (930s left) gem_flink_basic (bad-open)
[69.666235] Starting subtest: bad-open
[69.667716] Subtest bad-open: SUCCESS (0.000s)
[69.746891] [031/161] (930s left) gem_flink_basic (basic)
[69.789167] Starting subtest: basic
[69.790808] Subtest basic: SUCCESS (0.000s)
[69.944055] [032/161] (930s left) gem_flink_basic (double-flink)
[69.986607] Starting subtest: double-flink
[69.988200] Subtest double-flink: SUCCESS (0.000s)
[70.134194] [033/161] (930s left) gem_flink_basic (flink-lifetime)
[70.175233] Starting subtest: flink-lifetime
[70.176812] Subtest flink-lifetime: SUCCESS (0.001s)
[70.313878] [034/161] (930s left) gem_huc_copy (huc-copy)
[70.359580] Starting subtest: huc-copy
[70.363498] Subtest huc-copy: SKIP (0.000s)
[70.530265] [035/161] (929s left) gem_linear_blits (basic)
[70.634131] Starting subtest: basic
[70.644467] Subtest basic: SUCCESS (0.010s)
[70.799698] [036/161] (929s left) gem_mmap (basic)
[70.892684] Starting subtest: basic
[70.900885] Subtest basic: SUCCESS (0.000s)
[71.066692] [037/161] (929s left) gem_mmap_gtt (basic)
[71.112203] Starting subtest: basic
[71.114193] Subtest basic: SUCCESS (0.001s)
[71.202067] [038/161] (929s left) gem_render_linear_blits (basic)
[71.248188] Starting subtest: basic
[71.271620] Subtest basic: SUCCESS (0.024s)
[71.334228] [039/161] (929s left) gem_render_tiled_blits (basic)
[71.380436] Starting subtest: basic
[71.410905] Subtest basic: SUCCESS (0.031s)
[71.496150] [040/161] (929s left) gem_ringfill (basic-all)
[71.751718] Starting subtest: basic-all
[72.895934] Subtest basic-all: SUCCESS (1.144s)
[73.059696] [041/161] (927s left) gem_softpin (allocator-basic)
[73.104973] Starting subtest: allocator-basic
[73.200077] Subtest allocator-basic: SUCCESS (0.095s)
[73.381438] [042/161] (927s left) gem_softpin (allocator-basic-reserve)
[73.426700] Starting subtest: allocator-basic-reserve
[73.511344] Subtest allocator-basic-reserve: SUCCESS (0.085s)
[73.657559] [043/161] (927s left) gem_softpin (safe-alignment)
[73.704628] Starting subtest: safe-alignment
[73.713091] Subtest safe-alignment: SUCCESS (0.008s)
[73.901397] [044/161] (926s left) gem_sync (basic-all)
[73.958855] Starting subtest: basic-all
[76.026145] Subtest basic-all: SUCCESS (2.072s)
[76.209797] [045/161] (924s left) gem_sync (basic-each)
[76.267711] Starting subtest: basic-each
[78.374943] Subtest basic-each: SUCCESS (2.112s)
[78.637577] [046/161] (922s left) gem_tiled_blits (basic)
[78.727157] Starting subtest: basic
[78.746106] Subtest basic: SUCCESS (0.019s)
[78.953559] [047/161] (922s left) gem_tiled_fence_blits (basic)
[79.108177] Starting subtest: basic
[79.116905] Subtest basic: SUCCESS (0.009s)
[79.308433] [048/161] (921s left) gem_tiled_pread_basic
[79.614354] [049/161] (921s left) gem_wait (busy@all-engines)
[79.671802] Starting subtest: busy
[79.673547] Starting dynamic subtest: all-engines
[80.204900] Dynamic subtest all-engines: SUCCESS (0.533s)
[80.206512] Subtest busy: SUCCESS (0.533s)
[80.421156] [050/161] (920s left) gem_wait (wait@all-engines)
[80.476878] Starting subtest: wait
[80.478492] Starting dynamic subtest: all-engines
[81.518176] Dynamic subtest all-engines: SUCCESS (1.040s)
[81.521272] Subtest wait: SUCCESS (1.041s)
[81.798726] [051/161] (919s left) i915_getparams_basic (basic-eu-total)
[81.841297] Starting subtest: basic-eu-total
[81.844696] Subtest basic-eu-total: SUCCESS (0.000s)
[81.952668] [052/161] (919s left) i915_getparams_basic (basic-subslice-total)
[81.995819] Starting subtest: basic-subslice-total
[81.999041] Subtest basic-subslice-total: SUCCESS (0.000s)
[82.087774] [053/161] (919s left) i915_hangman (error-state-basic)
[82.140287] Starting subtest: error-state-basic
[82.146092] Subtest error-state-basic: SUCCESS (0.005s)
[82.221396] [054/161] (919s left) i915_pciid
[82.340769] [055/161] (919s left) kms_addfb_basic (addfb25-4-tiled)
[82.457330] Starting subtest: addfb25-4-tiled
[82.459176] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[82.633657] [056/161] (918s left) kms_addfb_basic (addfb25-bad-modifier)
[82.746942] Starting subtest: addfb25-bad-modifier
[82.748746] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[82.910385] [057/161] (918s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[83.020946] Starting subtest: addfb25-framebuffer-vs-set-tiling
[83.022626] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[83.196402] [058/161] (918s left) kms_addfb_basic (addfb25-modifier-no-flag)
[83.309934] Starting subtest: addfb25-modifier-no-flag
[83.311491] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[83.443894] [059/161] (918s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[83.557137] Starting subtest: addfb25-x-tiled-legacy
[83.558861] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[83.733673] [060/161] (918s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[83.845990] Starting subtest: addfb25-x-tiled-mismatch-legacy
[83.847620] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[84.034370] [061/161] (917s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[84.144063] Starting subtest: addfb25-yf-tiled-legacy
[84.145887] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[84.260233] [062/161] (917s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[84.372089] Starting subtest: addfb25-y-tiled-legacy
[84.373694] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[84.549104] [063/161] (917s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[84.661525] Starting subtest: addfb25-y-tiled-small-legacy
[84.663155] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s)
[84.810931] [064/161] (917s left) kms_addfb_basic (bad-pitch-0)
[84.853999] Starting subtest: bad-pitch-0
[84.855638] Subtest bad-pitch-0: SUCCESS (0.000s)
[85.102796] [065/161] (917s left) kms_addfb_basic (bad-pitch-1024)
[85.145180] Starting subtest: bad-pitch-1024
[85.146788] Subtest bad-pitch-1024: SUCCESS (0.000s)
[85.383319] [066/161] (916s left) kms_addfb_basic (bad-pitch-128)
[85.425090] Starting subtest: bad-pitch-128
[85.426718] Subtest bad-pitch-128: SUCCESS (0.000s)
[85.630567] [067/161] (916s left) kms_addfb_basic (bad-pitch-256)
[85.675392] Starting subtest: bad-pitch-256
[85.676878] Subtest bad-pitch-256: SUCCESS (0.000s)
[85.846377] [068/161] (916s left) kms_addfb_basic (bad-pitch-32)
[85.888614] Starting subtest: bad-pitch-32
[85.890109] Subtest bad-pitch-32: SUCCESS (0.000s)
[86.103175] [069/161] (916s left) kms_addfb_basic (bad-pitch-63)
[86.147729] Starting subtest: bad-pitch-63
[86.149047] Subtest bad-pitch-63: SUCCESS (0.000s)
[86.398934] [070/161] (916s left) kms_addfb_basic (bad-pitch-65536)
[86.441950] Starting subtest: bad-pitch-65536
[86.443392] Subtest bad-pitch-65536: SUCCESS (0.000s)
[86.648209] [071/161] (915s left) kms_addfb_basic (bad-pitch-999)
[86.689997] Starting subtest: bad-pitch-999
[86.691646] Subtest bad-pitch-999: SUCCESS (0.000s)
[86.920013] [072/161] (915s left) kms_addfb_basic (basic)
[86.965633] Starting subtest: basic
[86.966997] Subtest basic: SUCCESS (0.000s)
[87.171936] [073/161] (915s left) kms_addfb_basic (basic-x-tiled-legacy)
[87.214179] Starting subtest: basic-x-tiled-legacy
[87.215767] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[87.377828] [074/161] (915s left) kms_addfb_basic (basic-y-tiled-legacy)
[87.420749] Starting subtest: basic-y-tiled-legacy
[87.422183] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[87.602651] [075/161] (915s left) kms_addfb_basic (bo-too-small)
[87.712918] Starting subtest: bo-too-small
[87.714517] Subtest bo-too-small: SUCCESS (0.000s)
[87.847795] [076/161] (915s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[87.960934] Starting subtest: bo-too-small-due-to-tiling
[87.962512] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[88.085325] [077/161] (914s left) kms_addfb_basic (clobberred-modifier)
[88.126789] Starting subtest: clobberred-modifier
[88.128145] Subtest clobberred-modifier: SUCCESS (0.000s)
[88.368503] [078/161] (914s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[88.412628] Starting subtest: framebuffer-vs-set-tiling
[88.413891] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[88.648783] [079/161] (914s left) kms_addfb_basic (invalid-get-prop)
[88.692151] Starting subtest: invalid-get-prop
[88.693730] Subtest invalid-get-prop: SUCCESS (0.000s)
[88.933357] [080/161] (914s left) kms_addfb_basic (invalid-get-prop-any)
[88.976916] Starting subtest: invalid-get-prop-any
[88.978422] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[89.177507] [081/161] (914s left) kms_addfb_basic (invalid-set-prop)
[89.221892] Starting subtest: invalid-set-prop
[89.223435] Subtest invalid-set-prop: SUCCESS (0.000s)
[89.398553] [082/161] (913s left) kms_addfb_basic (invalid-set-prop-any)
[89.441595] Starting subtest: invalid-set-prop-any
[89.443141] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[89.642268] [083/161] (913s left) kms_addfb_basic (no-handle)
[89.686142] Starting subtest: no-handle
[89.687798] Subtest no-handle: SUCCESS (0.000s)
[89.950732] [084/161] (913s left) kms_addfb_basic (size-max)
[90.059929] Starting subtest: size-max
[90.061523] Subtest size-max: SUCCESS (0.000s)
[90.233837] [085/161] (913s left) kms_addfb_basic (small-bo)
[90.345977] Starting subtest: small-bo
[90.347626] Subtest small-bo: SUCCESS (0.000s)
[90.518550] [086/161] (913s left) kms_addfb_basic (tile-pitch-mismatch)
[90.564204] Starting subtest: tile-pitch-mismatch
[90.565794] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[90.804085] [087/161] (912s left) kms_addfb_basic (too-high)
[90.914923] Starting subtest: too-high
[90.916552] Subtest too-high: SUCCESS (0.001s)
[91.037653] [088/161] (912s left) kms_addfb_basic (too-wide)
[91.149037] Starting subtest: too-wide
[91.150661] Subtest too-wide: SUCCESS (0.000s)
[91.272613] [089/161] (912s left) kms_addfb_basic (unused-handle)
[91.316745] Starting subtest: unused-handle
[91.318199] Subtest unused-handle: SUCCESS (0.000s)
[91.539350] [090/161] (912s left) kms_addfb_basic (unused-modifier)
[91.582109] Starting subtest: unused-modifier
[91.583636] Subtest unused-modifier: SUCCESS (0.000s)
[91.834234] [091/161] (912s left) kms_addfb_basic (unused-offsets)
[91.876298] Starting subtest: unused-offsets
[91.877879] Subtest unused-offsets: SUCCESS (0.000s)
[92.118512] [092/161] (911s left) kms_addfb_basic (unused-pitches)
[92.160517] Starting subtest: unused-pitches
[92.161822] Subtest unused-pitches: SUCCESS (0.000s)
[92.393098] [093/161] (911s left) kms_busy (basic)
[92.505924] Starting subtest: basic
[92.507581] Starting dynamic subtest: flip
[92.993588] Dynamic subtest flip: SUCCESS (0.485s)
[93.002177] Starting dynamic subtest: modeset
[93.421462] Dynamic subtest modeset: SUCCESS (0.427s)
[93.422989] Subtest basic: SUCCESS (0.914s)
[93.604363] [094/161] (910s left) kms_prop_blob (basic)
[93.650177] Starting subtest: basic
[93.651900] Subtest basic: SUCCESS (0.000s)
[93.753740] [095/161] (910s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[93.866601] Starting subtest: basic-busy-flip-before-cursor-atomic
[93.869922] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[93.962727] [096/161] (910s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[94.073390] Starting subtest: basic-busy-flip-before-cursor-legacy
[94.076849] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[94.166553] [097/161] (910s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[94.277275] Starting subtest: basic-flip-after-cursor-atomic
[95.178791] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.900s)
[95.361633] [098/161] (908s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[95.474226] Starting subtest: basic-flip-after-cursor-legacy
[96.368689] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.893s)
[96.520841] [099/161] (907s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[96.630407] Starting subtest: basic-flip-after-cursor-varying-size
[97.535961] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.904s)
[97.701063] [100/161] (906s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[97.812438] Starting subtest: basic-flip-before-cursor-atomic
[98.718833] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.905s)
[98.860373] [101/161] (905s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[98.971373] Starting subtest: basic-flip-before-cursor-legacy
[99.867870] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.895s)
[100.026638] [102/161] (904s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[100.139367] Starting subtest: basic-flip-before-cursor-varying-size
[101.042958] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.902s)
[101.207111] [103/161] (903s left) kms_dsc (dsc-basic)
[101.320341] Subtest dsc-basic: SKIP (0.000s)
[101.359168] [104/161] (903s left) kms_flip (basic-flip-vs-dpms)
[101.470180] Starting subtest: basic-flip-vs-dpms
[101.471813] Starting dynamic subtest: A-HDMI-A1
[102.280439] Dynamic subtest A-HDMI-A1: SUCCESS (0.809s)
[102.289075] Starting dynamic subtest: B-HDMI-A1
[103.064761] Dynamic subtest B-HDMI-A1: SUCCESS (0.782s)
[103.073586] Starting dynamic subtest: C-HDMI-A1
[103.842967] Dynamic subtest C-HDMI-A1: SUCCESS (0.777s)
[103.844503] Subtest basic-flip-vs-dpms: SUCCESS (2.373s)
[103.976785] [105/161] (900s left) kms_flip (basic-flip-vs-modeset)
[104.092143] Starting subtest: basic-flip-vs-modeset
[104.093732] Starting dynamic subtest: A-HDMI-A1
[104.947156] Dynamic subtest A-HDMI-A1: SUCCESS (0.852s)
[104.956815] Starting dynamic subtest: B-HDMI-A1
[105.764861] Dynamic subtest B-HDMI-A1: SUCCESS (0.817s)
[105.773537] Starting dynamic subtest: C-HDMI-A1
[106.595627] Dynamic subtest C-HDMI-A1: SUCCESS (0.830s)
[106.597010] Subtest basic-flip-vs-modeset: SUCCESS (2.504s)
[106.796148] [106/161] (897s left) kms_flip (basic-flip-vs-wf_vblank)
[106.915149] Starting subtest: basic-flip-vs-wf_vblank
[106.916735] Starting dynamic subtest: A-HDMI-A1
[108.012366] Dynamic subtest A-HDMI-A1: SUCCESS (1.096s)
[108.022056] Starting dynamic subtest: B-HDMI-A1
[109.105219] Dynamic subtest B-HDMI-A1: SUCCESS (1.092s)
[109.114354] Starting dynamic subtest: C-HDMI-A1
[110.198563] Dynamic subtest C-HDMI-A1: SUCCESS (1.092s)
[110.202222] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.286s)
[110.340217] [107/161] (894s left) kms_flip (basic-plain-flip)
[110.455641] Starting subtest: basic-plain-flip
[110.459739] Starting dynamic subtest: A-HDMI-A1
[111.279316] Dynamic subtest A-HDMI-A1: SUCCESS (0.822s)
[111.288319] Starting dynamic subtest: B-HDMI-A1
[112.088296] Dynamic subtest B-HDMI-A1: SUCCESS (0.808s)
[112.097244] Starting dynamic subtest: C-HDMI-A1
[112.899884] Dynamic subtest C-HDMI-A1: SUCCESS (0.809s)
[112.905706] Subtest basic-plain-flip: SUCCESS (2.450s)
[113.088906] [108/161] (891s left) kms_force_connector_basic (force-connector-state)
[113.237031] Starting subtest: force-connector-state
[113.560732] Subtest force-connector-state: SUCCESS (0.324s)
[113.954560] [109/161] (890s left) kms_force_connector_basic (force-edid)
[114.105758] Starting subtest: force-edid
[114.241790] Subtest force-edid: SUCCESS (0.138s)
[114.448464] [110/161] (890s left) kms_force_connector_basic (force-load-detect)
[114.594843] Starting subtest: force-load-detect
[114.597879] Subtest force-load-detect: SKIP (0.000s)
[114.797573] [111/161] (890s left) kms_force_connector_basic (prune-stale-modes)
[114.940648] Starting subtest: prune-stale-modes
[115.079657] Subtest prune-stale-modes: SUCCESS (0.138s)
[115.308384] [112/161] (889s left) kms_frontbuffer_tracking (basic)
[115.426408] Starting subtest: basic
[117.994142] Subtest basic: SUCCESS (2.571s)
[118.178085] [113/161] (886s left) kms_hdmi_inject (inject-audio)
[118.249513] Starting subtest: inject-audio
[118.386029] Subtest inject-audio: SUCCESS (0.136s)
[118.529471] [114/161] (886s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[118.643029] Starting subtest: compare-crc-sanitycheck-xr24
[118.644669] Starting dynamic subtest: pipe-A-HDMI-A-1
[119.026517] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.382s)
[119.036991] Starting dynamic subtest: pipe-B-HDMI-A-1
[119.352096] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.323s)
[119.362477] Starting dynamic subtest: pipe-C-HDMI-A-1
[119.680670] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.326s)
[119.682206] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.037s)
[119.840410] [115/161] (885s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[119.953088] Starting subtest: compare-crc-sanitycheck-nv12
[119.954739] Starting dynamic subtest: pipe-A-HDMI-A-1
[120.378805] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.424s)
[120.389447] Starting dynamic subtest: pipe-B-HDMI-A-1
[120.742957] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.361s)
[120.753286] Starting dynamic subtest: pipe-C-HDMI-A-1
[120.756487] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[120.758114] Subtest compare-crc-sanitycheck-nv12: SUCCESS (0.791s)
[120.904626] [116/161] (884s left) kms_pipe_crc_basic (hang-read-crc)
[121.016060] Starting subtest: hang-read-crc
[121.017702] Starting dynamic subtest: pipe-A-HDMI-A-1
[121.965363] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.947s)
[121.974557] Starting dynamic subtest: pipe-B-HDMI-A-1
[122.803176] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.836s)
[122.812566] Starting dynamic subtest: pipe-C-HDMI-A-1
[123.661987] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.858s)
[123.663620] Subtest hang-read-crc: SUCCESS (2.646s)
[123.781618] [117/161] (881s left) kms_pipe_crc_basic (nonblocking-crc)
[123.894109] Starting subtest: nonblocking-crc
[123.895759] Starting dynamic subtest: pipe-A-HDMI-A-1
[124.425306] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.529s)
[124.434190] Starting dynamic subtest: pipe-B-HDMI-A-1
[124.912025] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.484s)
[124.921695] Starting dynamic subtest: pipe-C-HDMI-A-1
[125.402170] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.489s)
[125.403820] Subtest nonblocking-crc: SUCCESS (1.507s)
[125.520647] [118/161] (879s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[125.632087] Starting subtest: nonblocking-crc-frame-sequence
[125.633710] Starting dynamic subtest: pipe-A-HDMI-A-1
[126.184421] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.549s)
[126.193712] Starting dynamic subtest: pipe-B-HDMI-A-1
[126.669659] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.484s)
[126.679755] Starting dynamic subtest: pipe-C-HDMI-A-1
[127.154939] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.485s)
[127.156508] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.523s)
[127.282494] [119/161] (878s left) kms_pipe_crc_basic (read-crc)
[127.395135] Starting subtest: read-crc
[127.396634] Starting dynamic subtest: pipe-A-HDMI-A-1
[127.868080] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.472s)
[127.878059] Starting dynamic subtest: pipe-B-HDMI-A-1
[128.287886] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.418s)
[128.296850] Starting dynamic subtest: pipe-C-HDMI-A-1
[128.712226] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.422s)
[128.713910] Subtest read-crc: SUCCESS (1.316s)
[128.830847] [120/161] (876s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[128.941127] Starting subtest: read-crc-frame-sequence
[128.942552] Starting dynamic subtest: pipe-A-HDMI-A-1
[129.425124] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.483s)
[129.434858] Starting dynamic subtest: pipe-B-HDMI-A-1
[129.861931] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.435s)
[129.870476] Starting dynamic subtest: pipe-C-HDMI-A-1
[130.316369] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.452s)
[130.317896] Subtest read-crc-frame-sequence: SUCCESS (1.374s)
[130.436322] [121/161] (875s left) kms_pm_backlight (basic-brightness)
[130.550194] Subtest basic-brightness: SKIP (0.000s)
[130.590471] [122/161] (874s left) kms_pm_rpm (basic-pci-d3-state)
[132.000113] Starting subtest: basic-pci-d3-state
[132.299742] Subtest basic-pci-d3-state: SUCCESS (0.299s)
[132.477186] [123/161] (873s left) kms_pm_rpm (basic-rte)
[132.520185] Starting subtest: basic-rte
[134.166837] Subtest basic-rte: SUCCESS (1.647s)
[134.655611] [124/161] (870s left) kms_psr (psr-primary-page-flip)
[134.769336] Subtest psr-primary-page-flip: SKIP (0.000s)
[134.825107] [125/161] (870s left) kms_psr (psr-cursor-plane-move)
[134.937204] Subtest psr-cursor-plane-move: SKIP (0.000s)
[134.995426] [126/161] (870s left) kms_psr (psr-sprite-plane-onoff)
[135.106186] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[135.156459] [127/161] (870s left) kms_psr (psr-primary-mmap-gtt)
[135.270186] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[135.353553] [128/161] (870s left) kms_setmode (basic-clone-single-crtc)
[135.399801] Starting subtest: basic-clone-single-crtc
[135.404449] Subtest basic-clone-single-crtc: SKIP (0.000s)
[135.510407] [129/161] (870s left) i915_pm_rps (basic-api)
[135.556326] Starting subtest: basic-api
[135.559728] Subtest basic-api: SUCCESS (0.002s)
[135.658360] [130/161] (870s left) prime_self_import (basic-llseek-bad)
[135.701426] Starting subtest: basic-llseek-bad
[135.704830] Subtest basic-llseek-bad: SUCCESS (0.001s)
[135.869821] [131/161] (870s left) prime_self_import (basic-llseek-size)
[135.909612] Starting subtest: basic-llseek-size
[135.912335] Subtest basic-llseek-size: SUCCESS (0.002s)
[136.048776] [132/161] (870s left) prime_self_import (basic-with_fd_dup)
[136.088124] Starting subtest: basic-with_fd_dup
[136.091081] Subtest basic-with_fd_dup: SUCCESS (0.002s)
[136.244205] [133/161] (869s left) prime_self_import (basic-with_one_bo)
[136.287132] Starting subtest: basic-with_one_bo
[136.289966] Subtest basic-with_one_bo: SUCCESS (0.002s)
[136.359652] [134/161] (869s left) prime_self_import (basic-with_one_bo_two_files)
[136.401120] Starting subtest: basic-with_one_bo_two_files
[136.404077] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s)
[136.529636] [135/161] (869s left) prime_self_import (basic-with_two_bos)
[136.570009] Starting subtest: basic-with_two_bos
[136.573206] Subtest basic-with_two_bos: SUCCESS (0.003s)
[136.720790] [136/161] (869s left) prime_vgem (basic-fence-flip)
[136.780020] Starting subtest: basic-fence-flip
[137.191507] Subtest basic-fence-flip: SUCCESS (0.411s)
[137.362439] [137/161] (868s left) prime_vgem (basic-fence-mmap)
[137.413382] Starting subtest: basic-fence-mmap
[137.433075] Subtest basic-fence-mmap: SUCCESS (0.019s)
[137.579342] [138/161] (868s left) prime_vgem (basic-fence-read)
[137.630718] Starting subtest: basic-fence-read
[137.670323] Subtest basic-fence-read: SUCCESS (0.041s)
[137.819081] [139/161] (868s left) prime_vgem (basic-gtt)
[137.899462] Starting subtest: basic-gtt
[137.908518] Subtest basic-gtt: SUCCESS (0.009s)
[138.083470] [140/161] (868s left) prime_vgem (basic-read)
[138.130130] Starting subtest: basic-read
[138.148219] Subtest basic-read: SUCCESS (0.018s)
[138.340364] [141/161] (868s left) prime_vgem (basic-write)
[138.396481] Starting subtest: basic-write
[138.416008] Subtest basic-write: SUCCESS (0.019s)
[138.572754] [142/161] (868s left) vgem_basic (setversion)
[138.625856] Starting subtest: setversion
[138.628788] Subtest setversion: SUCCESS (0.000s)
[138.723023] [143/161] (868s left) vgem_basic (create)
[138.775957] Starting subtest: create
[138.777601] Subtest create: SUCCESS (0.000s)
[138.860947] [144/161] (867s left) vgem_basic (debugfs)
[138.909041] Starting subtest: debugfs
[138.910683] Subtest debugfs: SUCCESS (0.000s)
[138.985442] [145/161] (867s left) vgem_basic (dmabuf-export)
[139.042452] Starting subtest: dmabuf-export
[139.045106] Subtest dmabuf-export: SUCCESS (0.002s)
[139.174118] [146/161] (867s left) vgem_basic (dmabuf-fence)
[139.225868] Starting subtest: dmabuf-fence
[139.227376] Subtest dmabuf-fence: SUCCESS (0.000s)
[139.315320] [147/161] (867s left) vgem_basic (dmabuf-fence-before)
[139.359112] Starting subtest: dmabuf-fence-before
[139.360810] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[139.430538] [148/161] (867s left) vgem_basic (dmabuf-mmap)
[139.477243] Starting subtest: dmabuf-mmap
[139.484111] Subtest dmabuf-mmap: SUCCESS (0.009s)
[139.552384] [149/161] (867s left) vgem_basic (mmap)
[139.609375] Starting subtest: mmap
[139.614155] Subtest mmap: SUCCESS (0.006s)
[139.691586] [150/161] (867s left) vgem_basic (second-client)
[139.742903] Starting subtest: second-client
[139.776297] Subtest second-client: SUCCESS (0.033s)
[139.882887] [151/161] (867s left) vgem_basic (sysfs)
[139.926546] Starting subtest: sysfs
[139.928230] Subtest sysfs: SUCCESS (0.000s)
[139.995780] [152/161] (867s left) core_hotunplug (unbind-rebind)
[140.093780] Starting subtest: unbind-rebind
[144.390850] Subtest unbind-rebind: SUCCESS (4.299s)
[144.428197] [153/161] (862s left) vgem_basic (unload)
[144.472974] Starting subtest: unload
[173.573108] Subtest unload: SUCCESS (29.101s)
[173.693186] [154/161] (833s left) i915_module_load (reload)
[173.737224] Starting subtest: reload
[177.528681] Subtest reload: SUCCESS (3.790s)
[177.582565] [FACT i915_module_load (reload)] deleted: kernel.kmod_is_loaded.vgem: true
[177.585556] [155/161] (829s left) gem_lmem_swapping (basic)
[177.651087] Subtest basic: SKIP (0.000s)
[177.691977] [156/161] (829s left) gem_lmem_swapping (parallel-random-engines)
[177.738834] Subtest parallel-random-engines: SKIP (0.000s)
[177.787457] [157/161] (829s left) gem_lmem_swapping (random-engines)
[177.833930] Subtest random-engines: SKIP (0.000s)
[177.872893] [158/161] (829s left) gem_lmem_swapping (verify-random)
[177.920078] Subtest verify-random: SKIP (0.000s)
[177.955095] [159/161] (829s left) i915_pm_rpm (module-reload)
[179.467579] Starting subtest: module-reload
[190.085960] Subtest module-reload: SUCCESS (10.618s)
[190.135392] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true
[190.138259] [160/161] (817s left) i915_selftest (live)
[190.186699] Starting subtest: live
[190.188232] Starting dynamic subtest: sanitycheck
[192.640526] Dynamic subtest sanitycheck: SUCCESS (2.453s)
[192.649393] Starting dynamic subtest: uncore
[194.969203] Dynamic subtest uncore: SUCCESS (2.328s)
[194.976817] Starting dynamic subtest: workarounds
[197.607921] Dynamic subtest workarounds: SUCCESS (2.638s)
[197.615127] Starting dynamic subtest: gt_engines
[200.450416] Dynamic subtest gt_engines: SUCCESS (2.841s)
[200.462278] Starting dynamic subtest: gt_timelines
[208.861647] Dynamic subtest gt_timelines: SUCCESS (8.410s)
[208.871363] Starting dynamic subtest: gt_contexts
[211.405534] Dynamic subtest gt_contexts: SUCCESS (2.542s)
[211.415435] Starting dynamic subtest: gt_lrc
[216.226413] Dynamic subtest gt_lrc: SUCCESS (4.820s)
[216.237608] Starting dynamic subtest: gt_mocs
[218.757292] Dynamic subtest gt_mocs: SUCCESS (2.530s)
[218.771042] Starting dynamic subtest: gt_pm
[225.510456] Dynamic subtest gt_pm: SUCCESS (6.752s)
[225.521104] Starting dynamic subtest: gt_heartbeat
[227.880250] Dynamic subtest gt_heartbeat: SUCCESS (2.369s)
[227.889226] Starting dynamic subtest: gt_tlb
[231.083294] Dynamic subtest gt_tlb: SUCCESS (3.202s)
[231.092421] Starting dynamic subtest: requests
[239.778208] Dynamic subtest requests: SUCCESS (8.694s)
[239.786126] Starting dynamic subtest: migrate
[245.592430] Dynamic subtest migrate: SUCCESS (5.813s)
[245.602714] Starting dynamic subtest: active
[247.910198] Dynamic subtest active: SUCCESS (2.317s)
[247.919068] Starting dynamic subtest: objects
[250.714239] Dynamic subtest objects: SUCCESS (2.803s)
[250.723268] Starting dynamic subtest: mman
[256.251242] Dynamic subtest mman: SUCCESS (5.536s)
[256.259289] Starting dynamic subtest: dmabuf
[258.848805] Dynamic subtest dmabuf: SUCCESS (2.596s)
[258.857746] Starting dynamic subtest: vma
[261.169314] Dynamic subtest vma: SUCCESS (2.319s)
[261.178663] Starting dynamic subtest: coherency
[264.165279] Dynamic subtest coherency: SUCCESS (2.995s)
[264.174465] Starting dynamic subtest: gtt
[274.102296] Dynamic subtest gtt: SUCCESS (9.936s)
[274.111349] Starting dynamic subtest: gem
[276.641451] Dynamic subtest gem: SUCCESS (2.538s)
[276.650850] Starting dynamic subtest: evict
[279.997800] Dynamic subtest evict: SUCCESS (3.355s)
[280.006876] Starting dynamic subtest: hugepages
[288.501771] Dynamic subtest hugepages: SUCCESS (8.503s)
[288.509865] Starting dynamic subtest: gem_contexts
[303.141320] Dynamic subtest gem_contexts: SUCCESS (14.639s)
[303.150175] Starting dynamic subtest: client
[305.606977] Dynamic subtest client: SUCCESS (2.465s)
[305.615746] Starting dynamic subtest: gem_migrate
[307.948274] Dynamic subtest gem_migrate: SUCCESS (2.340s)
[307.957060] Starting dynamic subtest: reset
[310.533215] Dynamic subtest reset: SUCCESS (2.584s)
[310.542579] Starting dynamic subtest: memory_region
[312.874506] Dynamic subtest memory_region: SUCCESS (2.340s)
[312.883837] Starting dynamic subtest: hangcheck
[338.280730] Dynamic subtest hangcheck: SUCCESS (25.405s)
[338.289061] Starting dynamic subtest: execlists
[349.214267] Dynamic subtest execlists: SUCCESS (10.933s)
[349.226727] Starting dynamic subtest: ring_submission
[351.646777] Dynamic subtest ring_submission: SUCCESS (2.431s)
[351.656415] Starting dynamic subtest: perf
[354.145405] Dynamic subtest perf: SUCCESS (2.498s)
[354.154481] Starting dynamic subtest: slpc
[356.554210] Dynamic subtest slpc: SUCCESS (2.408s)
[356.564478] Starting dynamic subtest: guc
[358.865164] Dynamic subtest guc: SUCCESS (2.310s)
[358.874226] Starting dynamic subtest: guc_multi_lrc
[361.256336] Dynamic subtest guc_multi_lrc: SUCCESS (2.390s)
[361.265673] Starting dynamic subtest: guc_hang
[363.670206] Dynamic subtest guc_hang: SUCCESS (2.412s)
[363.679526] Starting dynamic subtest: late_gt_pm
[366.054328] Dynamic subtest late_gt_pm: SUCCESS (2.383s)
[366.056055] Subtest live: SUCCESS (175.871s)
[366.377999] [161/161] (641s left) dmabuf (all-tests)
[366.429865] Starting subtest: all-tests
[366.432173] Starting dynamic subtest: sanitycheck
[366.554655] Dynamic subtest sanitycheck: SUCCESS (0.123s)
[366.592751] Starting dynamic subtest: dma_fence
[366.843588] Dynamic subtest dma_fence: SUCCESS (0.283s)
[366.882750] Starting dynamic subtest: dma_fence_chain
[376.177367] Dynamic subtest dma_fence_chain: SUCCESS (9.328s)
[376.193049] Starting dynamic subtest: dma_fence_unwrap
[376.279724] Dynamic subtest dma_fence_unwrap: SUCCESS (0.099s)
[376.291612] Starting dynamic subtest: dma_resv
[376.390202] Dynamic subtest dma_resv: SUCCESS (0.107s)
[376.392893] Subtest all-tests: SUCCESS (9.962s)
[376.471721] Closing watchdogs
Done.