[55.222850] Initializing watchdogs
[55.222968]   /dev/watchdog0
[55.241259] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[55.250848] [001/162] (960s left) i915_module_load (load)
[55.306036] Starting subtest: load
[58.897662] Subtest load: SUCCESS (3.528s)
[58.934398] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.936011] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[58.945359] [002/162] (956s left) core_auth (basic-auth)
[60.252677] Starting subtest: basic-auth
[60.260878] Subtest basic-auth: SUCCESS (0.002s)
[60.369380] [003/162] (955s left) core_debugfs (read-all-entries)
[60.423153] Starting subtest: read-all-entries
[60.513925] Subtest read-all-entries: SUCCESS (0.084s)
[60.588549] [004/162] (955s left) core_sysfs (read-all-entries)
[60.660336] Starting subtest: read-all-entries
[60.666086] Subtest read-all-entries: SUCCESS (0.006s)
[60.776496] [005/162] (955s left) fbdev (eof)
[60.837095] Starting subtest: eof
[60.842576] Subtest eof: SUCCESS (0.000s)
[60.905503] [006/162] (955s left) fbdev (info)
[60.949843] Starting subtest: info
[60.955386] Subtest info: SUCCESS (0.000s)
[61.039346] [007/162] (954s left) fbdev (nullptr)
[61.106116] Starting subtest: nullptr
[61.111714] Subtest nullptr: SUCCESS (0.000s)
[61.187768] [008/162] (954s left) fbdev (read)
[61.243138] Starting subtest: read
[61.763583] Subtest read: SUCCESS (0.508s)
[61.847975] [009/162] (954s left) fbdev (write)
[61.903162] Starting subtest: write
[62.262197] Subtest write: SUCCESS (0.349s)
[62.333640] [010/162] (953s left) gem_basic (bad-close)
[62.398291] Starting subtest: bad-close
[62.409317] Subtest bad-close: SUCCESS (0.000s)
[62.513740] [011/162] (953s left) gem_basic (create-close)
[62.573370] Starting subtest: create-close
[62.585671] Subtest create-close: SUCCESS (0.000s)
[62.675764] [012/162] (953s left) gem_basic (create-fd-close)
[62.730672] Starting subtest: create-fd-close
[62.743612] Subtest create-fd-close: SUCCESS (0.000s)
[62.855657] [013/162] (953s left) gem_busy (busy@all-engines)
[62.923987] Starting subtest: busy
[62.929948] Starting dynamic subtest: all-engines
[62.993677] Dynamic subtest all-engines: SUCCESS (0.072s)
[62.999096] Subtest busy: SUCCESS (0.072s)
[64.365400] [014/162] (951s left) gem_close_race (basic-process)
[64.436240] Starting subtest: basic-process
[64.480521] Subtest basic-process: SUCCESS (0.040s)
[64.682201] [015/162] (951s left) gem_close_race (basic-threads)
[64.746361] Starting subtest: basic-threads
[66.030410] Subtest basic-threads: SUCCESS (1.281s)
[66.220802] [016/162] (950s left) gem_ctx_create (basic)
[66.289216] Starting subtest: basic
[66.294732] Subtest basic: SUCCESS (0.000s)
[66.474244] [017/162] (949s left) gem_ctx_create (basic-files)
[66.552566] Starting subtest: basic-files
[68.602607] Subtest basic-files: SUCCESS (2.028s)
[70.311468] [018/162] (946s left) gem_ctx_exec (basic)
[70.368377] Starting subtest: basic
[70.379492] Subtest basic: SUCCESS (0.009s)
[70.509345] [019/162] (946s left) gem_exec_basic (basic)
[70.583156] Starting subtest: basic
[70.588583] Starting dynamic subtest: rcs0-smem
[70.594085] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[70.607551] Starting dynamic subtest: bcs0-smem
[70.615830] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[70.626602] Starting dynamic subtest: vcs0-smem
[70.633806] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[70.644147] Starting dynamic subtest: vcs1-smem
[70.649596] Dynamic subtest vcs1-smem: SUCCESS (0.002s)
[70.660128] Starting dynamic subtest: vecs0-smem
[70.665636] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[70.676463] Starting dynamic subtest: ccs0-smem
[70.684873] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[70.690282] Subtest basic: SUCCESS (0.011s)
[72.370785] [020/162] (944s left) gem_exec_create (basic)
[72.648029] Starting subtest: basic
[72.653651] Starting dynamic subtest: smem
[76.218266] Dynamic subtest smem: SUCCESS (3.558s)
[76.224082] Subtest basic: SUCCESS (3.559s)
[76.416400] [021/162] (940s left) gem_exec_fence (basic-busy)
[76.597964] Starting subtest: basic-busy
[76.603766] Starting dynamic subtest: rcs0
[76.670965] Dynamic subtest rcs0: SUCCESS (0.074s)
[76.683797] Starting dynamic subtest: bcs0
[76.722506] Dynamic subtest bcs0: SUCCESS (0.051s)
[76.736330] Starting dynamic subtest: vcs0
[76.774578] Dynamic subtest vcs0: SUCCESS (0.051s)
[76.786810] Starting dynamic subtest: vcs1
[76.826687] Dynamic subtest vcs1: SUCCESS (0.051s)
[76.839262] Starting dynamic subtest: vecs0
[76.876597] Dynamic subtest vecs0: SUCCESS (0.050s)
[76.891297] Starting dynamic subtest: ccs0
[76.925674] Dynamic subtest ccs0: SUCCESS (0.049s)
[76.931180] Subtest basic-busy: SUCCESS (0.329s)
[78.326672] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[78.333133] [022/162] (938s left) gem_exec_fence (basic-wait)
[78.520115] Starting subtest: basic-wait
[78.525673] Starting dynamic subtest: rcs0
[78.618046] Dynamic subtest rcs0: SUCCESS (0.097s)
[78.630990] Starting dynamic subtest: bcs0
[78.681261] Dynamic subtest bcs0: SUCCESS (0.061s)
[78.693762] Starting dynamic subtest: vcs0
[78.737973] Dynamic subtest vcs0: SUCCESS (0.053s)
[78.750605] Starting dynamic subtest: vcs1
[78.806686] Dynamic subtest vcs1: SUCCESS (0.068s)
[78.819374] Starting dynamic subtest: vecs0
[78.866422] Dynamic subtest vecs0: SUCCESS (0.062s)
[78.877923] Starting dynamic subtest: ccs0
[78.924495] Dynamic subtest ccs0: SUCCESS (0.055s)
[78.930115] Subtest basic-wait: SUCCESS (0.403s)
[80.371974] [023/162] (936s left) gem_exec_fence (basic-await)
[80.562620] Starting subtest: basic-await
[80.570737] Starting dynamic subtest: rcs0
[80.644186] Dynamic subtest rcs0: SUCCESS (0.081s)
[80.661637] Starting dynamic subtest: bcs0
[80.712652] Dynamic subtest bcs0: SUCCESS (0.071s)
[80.724783] Starting dynamic subtest: vcs0
[80.790627] Dynamic subtest vcs0: SUCCESS (0.073s)
[80.803118] Starting dynamic subtest: vcs1
[80.862218] Dynamic subtest vcs1: SUCCESS (0.074s)
[80.874788] Starting dynamic subtest: vecs0
[80.937191] Dynamic subtest vecs0: SUCCESS (0.071s)
[80.950399] Starting dynamic subtest: ccs0
[81.007038] Dynamic subtest ccs0: SUCCESS (0.070s)
[81.012759] Subtest basic-await: SUCCESS (0.444s)
[82.359179] [024/162] (934s left) gem_exec_fence (nb-await)
[82.542772] Starting subtest: nb-await
[82.551673] Starting dynamic subtest: rcs0
[82.607399] Dynamic subtest rcs0: SUCCESS (0.066s)
[82.621078] Starting dynamic subtest: bcs0
[82.670369] Dynamic subtest bcs0: SUCCESS (0.059s)
[82.681934] Starting dynamic subtest: vcs0
[82.730471] Dynamic subtest vcs0: SUCCESS (0.059s)
[82.745959] Starting dynamic subtest: vcs1
[82.784840] Dynamic subtest vcs1: SUCCESS (0.057s)
[82.799740] Starting dynamic subtest: vecs0
[82.845471] Dynamic subtest vecs0: SUCCESS (0.057s)
[82.861178] Starting dynamic subtest: ccs0
[82.899856] Dynamic subtest ccs0: SUCCESS (0.057s)
[82.905367] Subtest nb-await: SUCCESS (0.359s)
[84.345323] [025/162] (932s left) gem_exec_gttfill (basic)
[84.425865] Starting subtest: basic
[86.818076] Subtest basic: SUCCESS (2.397s)
[87.025669] [026/162] (929s left) gem_exec_parallel (engines)
[87.115941] Starting subtest: engines
[87.124654] Starting dynamic subtest: basic
[89.273028] Dynamic subtest basic: SUCCESS (2.148s)
[89.288178] Starting dynamic subtest: contexts
[93.278052] Dynamic subtest contexts: SUCCESS (4.002s)
[93.291920] Starting dynamic subtest: fds
[95.578053] Dynamic subtest fds: SUCCESS (2.298s)
[95.592181] Starting dynamic subtest: userptr
[186.938395] Inactivity timeout exceeded. Killing the current test with SIGQUIT.
[186.939187] Warning: kernel log ringbuffer underflow, some records lost.
[306.498361] Timeout. Killing the current test with SIGKILL.
[306.668182] Closing watchdogs
[306.671428] Initializing watchdogs
[306.671461]   /dev/watchdog0
[306.694625] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[306.701752] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[306.703415] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[306.703843] [FACT before any test] new: kernel.kmod_is_loaded.vgem: true
[306.711114] [027/162] (710s left) gem_exec_store (basic)
[307.248059] Starting subtest: basic
[307.334448] Subtest basic: SUCCESS (0.108s)
[307.543049] [028/162] (709s left) gem_flink_basic (bad-flink)
[307.593662] Starting subtest: bad-flink
[307.599127] Subtest bad-flink: SUCCESS (0.000s)
[307.716222] [029/162] (709s left) gem_flink_basic (bad-open)
[307.782549] Starting subtest: bad-open
[307.788032] Subtest bad-open: SUCCESS (0.000s)
[307.910322] [030/162] (709s left) gem_flink_basic (basic)
[307.979964] Starting subtest: basic
[307.985526] Subtest basic: SUCCESS (0.000s)
[308.104126] [031/162] (709s left) gem_flink_basic (double-flink)
[308.168720] Starting subtest: double-flink
[308.177225] Subtest double-flink: SUCCESS (0.000s)
[308.270860] [032/162] (708s left) gem_flink_basic (flink-lifetime)
[308.337528] Starting subtest: flink-lifetime
[308.345851] Subtest flink-lifetime: SUCCESS (0.001s)
[308.455749] [033/162] (708s left) gem_huc_copy (huc-copy)
[308.548151] Starting subtest: huc-copy
[308.557277] Subtest huc-copy: SUCCESS (0.004s)
[308.664335] [034/162] (708s left) gem_linear_blits (basic)
[308.869621] Starting subtest: basic
[308.886533] Subtest basic: SUCCESS (0.009s)
[309.016377] [035/162] (708s left) gem_mmap (basic)
[309.112186] Subtest basic: SKIP (0.000s)
[309.197278] [036/162] (708s left) gem_mmap_gtt (basic)
[309.266251] Subtest basic: SKIP (0.000s)
[309.354345] [037/162] (708s left) gem_render_linear_blits (basic)
[309.430869] Starting subtest: basic
[309.457795] Subtest basic: SUCCESS (0.026s)
[309.553983] [038/162] (707s left) gem_render_tiled_blits (basic)
[309.619011] Subtest basic: SKIP (0.000s)
[309.694678] [039/162] (707s left) gem_ringfill (basic-all)
[315.330039] Starting subtest: basic-all
[316.478851] Subtest basic-all: SUCCESS (1.154s)
[316.572971] [040/162] (701s left) gem_softpin (allocator-basic)
[316.637543] Starting subtest: allocator-basic
[316.710857] Subtest allocator-basic: SUCCESS (0.071s)
[316.847131] [041/162] (700s left) gem_softpin (allocator-basic-reserve)
[316.903300] Starting subtest: allocator-basic-reserve
[316.981844] Subtest allocator-basic-reserve: SUCCESS (0.078s)
[317.119288] [042/162] (700s left) gem_softpin (safe-alignment)
[317.189532] Starting subtest: safe-alignment
[317.207987] Subtest safe-alignment: SUCCESS (0.021s)
[318.312086] [043/162] (699s left) gem_sync (basic-all)
[318.419740] Starting subtest: basic-all
[322.300349] Subtest basic-all: SUCCESS (3.909s)
[322.495961] [044/162] (695s left) gem_sync (basic-each)
[322.602938] Starting subtest: basic-each
[324.884737] Subtest basic-each: SUCCESS (2.321s)
[325.082250] [045/162] (692s left) gem_tiled_blits (basic)
[325.160044] Subtest basic: SKIP (0.000s)
[325.237260] [046/162] (692s left) gem_tiled_fence_blits (basic)
[325.310464] Subtest basic: SKIP (0.000s)
[325.384106] [047/162] (692s left) gem_tiled_pread_basic (basic)
[325.443525] Subtest basic: SKIP (0.000s)
[325.495738] [048/162] (692s left) gem_wait (busy@all-engines)
[325.562015] Starting subtest: busy
[325.567404] Starting dynamic subtest: all-engines
[327.288015] Dynamic subtest all-engines: SUCCESS (1.717s)
[327.297376] Subtest busy: SUCCESS (1.719s)
[327.505970] [049/162] (690s left) gem_wait (wait@all-engines)
[327.560284] Starting subtest: wait
[327.567999] Starting dynamic subtest: all-engines
[329.274949] Dynamic subtest all-engines: SUCCESS (1.704s)
[329.280714] Subtest wait: SUCCESS (1.705s)
[329.487579] [050/162] (688s left) i915_getparams_basic (basic-eu-total)
[329.544398] Starting subtest: basic-eu-total
[329.555391] Subtest basic-eu-total: SUCCESS (0.000s)
[329.640353] [051/162] (688s left) i915_getparams_basic (basic-subslice-total)
[329.703684] Starting subtest: basic-subslice-total
[329.716980] Subtest basic-subslice-total: SUCCESS (0.000s)
[329.806323] [052/162] (688s left) i915_hangman (error-state-basic)
[329.879012] Starting subtest: error-state-basic
[329.998399] Subtest error-state-basic: SUCCESS (0.113s)
[330.082594] [053/162] (688s left) i915_pciid
[330.254525] [054/162] (688s left) intel_hwmon (hwmon-read)
[330.318399] Subtest hwmon-read: SKIP (0.000s)
[330.387774] [055/162] (687s left) intel_hwmon (hwmon-write)
[330.454694] Subtest hwmon-write: SKIP (0.000s)
[330.524841] [056/162] (687s left) kms_addfb_basic (addfb25-4-tiled)
[330.865892] Starting subtest: addfb25-4-tiled
[330.871277] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[330.969865] [057/162] (687s left) kms_addfb_basic (addfb25-bad-modifier)
[331.291455] Starting subtest: addfb25-bad-modifier
[331.296999] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[331.423809] [058/162] (687s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[331.721405] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[331.837157] [059/162] (686s left) kms_addfb_basic (addfb25-modifier-no-flag)
[332.108165] Starting subtest: addfb25-modifier-no-flag
[332.113497] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[332.258221] [060/162] (686s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[332.556261] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[332.662329] [061/162] (685s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[332.982187] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[333.088746] [062/162] (685s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[333.399320] Starting subtest: addfb25-yf-tiled-legacy
[333.404738] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[333.523695] [063/162] (685s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[333.845209] Starting subtest: addfb25-y-tiled-legacy
[333.850514] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[333.954743] [064/162] (684s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[334.256792] Starting subtest: addfb25-y-tiled-small-legacy
[334.267666] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[334.356017] [065/162] (684s left) kms_addfb_basic (bad-pitch-0)
[334.423864] Starting subtest: bad-pitch-0
[334.429480] Subtest bad-pitch-0: SUCCESS (0.000s)
[334.812678] [066/162] (684s left) kms_addfb_basic (bad-pitch-1024)
[334.871372] Starting subtest: bad-pitch-1024
[334.876847] Subtest bad-pitch-1024: SUCCESS (0.000s)
[335.214572] [067/162] (683s left) kms_addfb_basic (bad-pitch-128)
[335.271549] Starting subtest: bad-pitch-128
[335.277139] Subtest bad-pitch-128: SUCCESS (0.000s)
[335.656410] [068/162] (683s left) kms_addfb_basic (bad-pitch-256)
[335.710216] Starting subtest: bad-pitch-256
[335.715665] Subtest bad-pitch-256: SUCCESS (0.000s)
[336.110724] [069/162] (682s left) kms_addfb_basic (bad-pitch-32)
[336.175342] Starting subtest: bad-pitch-32
[336.180848] Subtest bad-pitch-32: SUCCESS (0.000s)
[336.556298] [070/162] (682s left) kms_addfb_basic (bad-pitch-63)
[336.612206] Starting subtest: bad-pitch-63
[336.617724] Subtest bad-pitch-63: SUCCESS (0.000s)
[336.992836] [071/162] (682s left) kms_addfb_basic (bad-pitch-65536)
[337.055519] Starting subtest: bad-pitch-65536
[337.062836] Subtest bad-pitch-65536: SUCCESS (0.000s)
[337.407503] [072/162] (681s left) kms_addfb_basic (bad-pitch-999)
[337.483509] Starting subtest: bad-pitch-999
[337.488889] Subtest bad-pitch-999: SUCCESS (0.000s)
[337.884287] [073/162] (681s left) kms_addfb_basic (basic)
[337.954370] Starting subtest: basic
[337.959921] Subtest basic: SUCCESS (0.000s)
[338.383509] [074/162] (680s left) kms_addfb_basic (basic-x-tiled-legacy)
[338.437914] Starting subtest: basic-x-tiled-legacy
[338.455326] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[338.797117] [075/162] (680s left) kms_addfb_basic (basic-y-tiled-legacy)
[338.869315] Starting subtest: basic-y-tiled-legacy
[338.882479] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[339.257185] [076/162] (680s left) kms_addfb_basic (bo-too-small)
[339.560869] Starting subtest: bo-too-small
[339.568660] Subtest bo-too-small: SUCCESS (0.000s)
[339.687826] [077/162] (679s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[340.005997] Starting subtest: bo-too-small-due-to-tiling
[340.016938] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[340.129790] [078/162] (679s left) kms_addfb_basic (clobberred-modifier)
[340.194240] Starting subtest: clobberred-modifier
[340.205512] Subtest clobberred-modifier: SKIP (0.000s)
[340.577399] [079/162] (678s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[340.645799] Starting subtest: framebuffer-vs-set-tiling
[340.656616] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[341.024235] [080/162] (678s left) kms_addfb_basic (invalid-get-prop)
[341.097017] Starting subtest: invalid-get-prop
[341.105922] Subtest invalid-get-prop: SUCCESS (0.000s)
[341.433901] [081/162] (678s left) kms_addfb_basic (invalid-get-prop-any)
[341.497925] Starting subtest: invalid-get-prop-any
[341.504823] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[341.841392] [082/162] (677s left) kms_addfb_basic (invalid-set-prop)
[341.906628] Starting subtest: invalid-set-prop
[341.912130] Subtest invalid-set-prop: SUCCESS (0.000s)
[342.284991] [083/162] (677s left) kms_addfb_basic (invalid-set-prop-any)
[342.345504] Starting subtest: invalid-set-prop-any
[342.351075] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[342.713380] [084/162] (677s left) kms_addfb_basic (no-handle)
[342.774899] Starting subtest: no-handle
[342.783985] Subtest no-handle: SUCCESS (0.000s)
[343.123814] [085/162] (676s left) kms_addfb_basic (size-max)
[343.418531] Starting subtest: size-max
[343.423795] Subtest size-max: SUCCESS (0.000s)
[343.550437] [086/162] (676s left) kms_addfb_basic (small-bo)
[343.875118] Starting subtest: small-bo
[343.880567] Subtest small-bo: SUCCESS (0.000s)
[344.005853] [087/162] (675s left) kms_addfb_basic (tile-pitch-mismatch)
[344.066607] Starting subtest: tile-pitch-mismatch
[344.079851] Subtest tile-pitch-mismatch: SKIP (0.000s)
[344.440644] [088/162] (675s left) kms_addfb_basic (too-high)
[344.752808] Starting subtest: too-high
[344.758189] Subtest too-high: SUCCESS (0.001s)
[344.877321] [089/162] (675s left) kms_addfb_basic (too-wide)
[345.249974] Starting subtest: too-wide
[345.258852] Subtest too-wide: SUCCESS (0.000s)
[345.374224] [090/162] (674s left) kms_addfb_basic (unused-handle)
[345.450520] Starting subtest: unused-handle
[345.458561] Subtest unused-handle: SUCCESS (0.000s)
[345.836074] [091/162] (674s left) kms_addfb_basic (unused-modifier)
[345.892995] Starting subtest: unused-modifier
[345.898550] Subtest unused-modifier: SUCCESS (0.000s)
[346.249305] [092/162] (673s left) kms_addfb_basic (unused-offsets)
[346.308622] Starting subtest: unused-offsets
[346.314129] Subtest unused-offsets: SUCCESS (0.000s)
[346.648255] [093/162] (673s left) kms_addfb_basic (unused-pitches)
[346.718517] Starting subtest: unused-pitches
[346.726279] Subtest unused-pitches: SUCCESS (0.000s)
[347.047294] [094/162] (673s left) kms_busy (basic)
[347.392874] Starting subtest: basic
[347.400203] Starting dynamic subtest: flip
[349.760634] Dynamic subtest flip: SUCCESS (2.351s)
[349.775453] Starting dynamic subtest: modeset
[352.717417] Dynamic subtest modeset: SUCCESS (2.962s)
[352.723319] Subtest basic: SUCCESS (5.317s)
[353.830503] [095/162] (666s left) kms_prop_blob (basic)
[353.898091] Starting subtest: basic
[353.903601] Subtest basic: SUCCESS (0.000s)
[354.019674] [096/162] (666s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[354.339784] Starting subtest: basic-busy-flip-before-cursor-atomic
[354.354197] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[354.511975] [097/162] (665s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[354.823560] Starting subtest: basic-busy-flip-before-cursor-legacy
[354.834578] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[355.000447] [098/162] (665s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[355.311277] Starting subtest: basic-flip-after-cursor-atomic
[356.552288] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.238s)
[357.661829] [099/162] (662s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[358.033352] Starting subtest: basic-flip-after-cursor-legacy
[359.268404] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.229s)
[360.409227] [100/162] (660s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[360.736413] Starting subtest: basic-flip-after-cursor-varying-size
[361.999972] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.259s)
[363.157803] [101/162] (657s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[363.489450] Starting subtest: basic-flip-before-cursor-atomic
[364.740509] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.247s)
[365.953670] [102/162] (654s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[366.267387] Starting subtest: basic-flip-before-cursor-legacy
[367.515811] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.242s)
[368.786370] [103/162] (652s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[369.129066] Starting subtest: basic-flip-before-cursor-varying-size
[370.396878] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.270s)
[371.529832] [104/162] (649s left) kms_dsc (dsc-basic)
[371.832263] Starting subtest: dsc-basic
[371.919025] Subtest dsc-basic: SKIP (0.001s)
[371.988663] [105/162] (648s left) kms_flip (basic-flip-vs-dpms)
[372.316159] Starting subtest: basic-flip-vs-dpms
[372.321671] Starting dynamic subtest: A-eDP1
[375.368276] Dynamic subtest A-eDP1: SUCCESS (3.048s)
[375.382687] Starting dynamic subtest: B-eDP1
[377.529704] Dynamic subtest B-eDP1: SUCCESS (2.167s)
[377.544224] Starting dynamic subtest: C-eDP1
[379.620050] Dynamic subtest C-eDP1: SUCCESS (2.088s)
[379.632652] Starting dynamic subtest: D-eDP1
[381.704708] Dynamic subtest D-eDP1: SUCCESS (2.078s)
[381.718913] Starting dynamic subtest: A-DP6
[382.650677] Dynamic subtest A-DP6: SUCCESS (0.950s)
[382.663089] Starting dynamic subtest: B-DP6
[383.597534] Dynamic subtest B-DP6: SUCCESS (0.947s)
[383.609921] Starting dynamic subtest: C-DP6
[384.522125] Dynamic subtest C-DP6: SUCCESS (0.919s)
[384.537662] Starting dynamic subtest: D-DP6
[385.450361] Dynamic subtest D-DP6: SUCCESS (0.928s)
[385.465820] Starting dynamic subtest: A-DP7
[386.393833] Dynamic subtest A-DP7: SUCCESS (0.939s)
[386.406462] Starting dynamic subtest: B-DP7
[387.341468] Dynamic subtest B-DP7: SUCCESS (0.945s)
[387.357075] Starting dynamic subtest: C-DP7
[388.270655] Dynamic subtest C-DP7: SUCCESS (0.932s)
[388.284669] Starting dynamic subtest: D-DP7
[389.180841] Dynamic subtest D-DP7: SUCCESS (0.908s)
[389.186350] Subtest basic-flip-vs-dpms: SUCCESS (16.868s)
[389.934766] [106/162] (631s left) kms_flip (basic-flip-vs-modeset)
[390.222618] Starting subtest: basic-flip-vs-modeset
[390.228175] Starting dynamic subtest: A-eDP1
[393.019978] Dynamic subtest A-eDP1: SUCCESS (2.793s)
[393.033070] Starting dynamic subtest: B-eDP1
[395.171961] Dynamic subtest B-eDP1: SUCCESS (2.152s)
[395.184871] Starting dynamic subtest: C-eDP1
[397.338711] Dynamic subtest C-eDP1: SUCCESS (2.166s)
[397.351189] Starting dynamic subtest: D-eDP1
[399.483308] Dynamic subtest D-eDP1: SUCCESS (2.144s)
[399.497678] Starting dynamic subtest: A-DP6
[400.446106] Dynamic subtest A-DP6: SUCCESS (0.963s)
[400.458482] Starting dynamic subtest: B-DP6
[401.399209] Dynamic subtest B-DP6: SUCCESS (0.949s)
[401.412506] Starting dynamic subtest: C-DP6
[402.331344] Dynamic subtest C-DP6: SUCCESS (0.936s)
[402.343645] Starting dynamic subtest: D-DP6
[403.259498] Dynamic subtest D-DP6: SUCCESS (0.925s)
[403.272110] Starting dynamic subtest: A-DP7
[404.211995] Dynamic subtest A-DP7: SUCCESS (0.951s)
[404.224975] Starting dynamic subtest: B-DP7
[405.163182] Dynamic subtest B-DP7: SUCCESS (0.944s)
[405.175378] Starting dynamic subtest: C-DP7
[406.094108] Dynamic subtest C-DP7: SUCCESS (0.930s)
[406.107713] Starting dynamic subtest: D-DP7
[407.013737] Dynamic subtest D-DP7: SUCCESS (0.924s)
[407.019117] Subtest basic-flip-vs-modeset: SUCCESS (16.796s)
[407.756741] [107/162] (613s left) kms_flip (basic-flip-vs-wf_vblank)
[408.054910] Starting subtest: basic-flip-vs-wf_vblank
[408.060323] Starting dynamic subtest: A-eDP1
[410.200442] Dynamic subtest A-eDP1: SUCCESS (2.143s)
[410.214137] Starting dynamic subtest: B-eDP1
[412.121370] Dynamic subtest B-eDP1: SUCCESS (1.919s)
[412.134260] Starting dynamic subtest: C-eDP1
[414.059692] Dynamic subtest C-eDP1: SUCCESS (1.925s)
[414.075303] Starting dynamic subtest: D-eDP1
[415.992596] Dynamic subtest D-eDP1: SUCCESS (1.930s)
[416.005025] Starting dynamic subtest: A-DP6
[417.396274] Dynamic subtest A-DP6: SUCCESS (1.418s)
[417.418984] Starting dynamic subtest: B-DP6
[418.692257] Dynamic subtest B-DP6: SUCCESS (1.294s)
[418.705577] Starting dynamic subtest: C-DP6
[419.979881] Dynamic subtest C-DP6: SUCCESS (1.283s)
[419.994989] Starting dynamic subtest: D-DP6
[421.271940] Dynamic subtest D-DP6: SUCCESS (1.290s)
[421.285148] Starting dynamic subtest: A-DP7
[422.569865] Dynamic subtest A-DP7: SUCCESS (1.299s)
[422.583605] Starting dynamic subtest: B-DP7
[423.864440] Dynamic subtest B-DP7: SUCCESS (1.289s)
[423.879892] Starting dynamic subtest: C-DP7
[425.159529] Dynamic subtest C-DP7: SUCCESS (1.290s)
[425.173343] Starting dynamic subtest: D-DP7
[426.439063] Dynamic subtest D-DP7: SUCCESS (1.274s)
[426.447392] Subtest basic-flip-vs-wf_vblank: SUCCESS (18.380s)
[427.345180] [108/162] (593s left) kms_flip (basic-plain-flip)
[427.693772] Starting subtest: basic-plain-flip
[427.702457] Starting dynamic subtest: A-eDP1
[429.621967] Dynamic subtest A-eDP1: SUCCESS (1.930s)
[429.634738] Starting dynamic subtest: B-eDP1
[431.339758] Dynamic subtest B-eDP1: SUCCESS (1.711s)
[431.357115] Starting dynamic subtest: C-eDP1
[432.950391] Dynamic subtest C-eDP1: SUCCESS (1.608s)
[432.967652] Starting dynamic subtest: D-eDP1
[434.593474] Dynamic subtest D-eDP1: SUCCESS (1.641s)
[434.605764] Starting dynamic subtest: A-DP6
[435.706803] Dynamic subtest A-DP6: SUCCESS (1.117s)
[435.720426] Starting dynamic subtest: B-DP6
[436.715488] Dynamic subtest B-DP6: SUCCESS (1.007s)
[436.728626] Starting dynamic subtest: C-DP6
[437.737602] Dynamic subtest C-DP6: SUCCESS (1.012s)
[437.752182] Starting dynamic subtest: D-DP6
[438.723522] Dynamic subtest D-DP6: SUCCESS (0.991s)
[438.736481] Starting dynamic subtest: A-DP7
[439.751899] Dynamic subtest A-DP7: SUCCESS (1.028s)
[439.767741] Starting dynamic subtest: B-DP7
[440.757837] Dynamic subtest B-DP7: SUCCESS (1.003s)
[440.771301] Starting dynamic subtest: C-DP7
[441.756558] Dynamic subtest C-DP7: SUCCESS (0.992s)
[441.769217] Starting dynamic subtest: D-DP7
[442.751522] Dynamic subtest D-DP7: SUCCESS (0.990s)
[442.757036] Subtest basic-plain-flip: SUCCESS (15.058s)
[443.656401] [109/162] (577s left) kms_force_connector_basic (force-connector-state)
[443.732285] Starting subtest: force-connector-state
[445.421700] Subtest force-connector-state: SUCCESS (1.689s)
[446.824020] [110/162] (574s left) kms_force_connector_basic (force-edid)
[446.888217] Starting subtest: force-edid
[447.181669] Subtest force-edid: SUCCESS (0.294s)
[447.656647] [111/162] (573s left) kms_force_connector_basic (force-load-detect)
[447.724792] Starting subtest: force-load-detect
[447.736106] Subtest force-load-detect: SKIP (0.000s)
[448.038863] [112/162] (573s left) kms_force_connector_basic (prune-stale-modes)
[448.109499] Starting subtest: prune-stale-modes
[448.468590] Subtest prune-stale-modes: SUCCESS (0.356s)
[449.006628] [113/162] (572s left) kms_frontbuffer_tracking (basic)
[449.342709] Starting subtest: basic
[453.404515] Subtest basic: SUCCESS (4.073s)
[453.918708] [114/162] (567s left) kms_hdmi_inject (inject-audio)
[455.015508] Starting subtest: inject-audio
[455.276226] Subtest inject-audio: SUCCESS (0.261s)
[456.241134] [115/162] (565s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[456.565430] Starting subtest: compare-crc-sanitycheck-xr24
[456.571087] Starting dynamic subtest: pipe-A-eDP-1
[458.070790] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.505s)
[458.084657] Starting dynamic subtest: pipe-B-DP-6
[458.747597] Dynamic subtest pipe-B-DP-6: SUCCESS (0.672s)
[458.760194] Starting dynamic subtest: pipe-C-DP-7
[459.380798] Dynamic subtest pipe-C-DP-7: SUCCESS (0.635s)
[459.394395] Starting dynamic subtest: pipe-D-DP-6
[460.026558] Dynamic subtest pipe-D-DP-6: SUCCESS (0.643s)
[460.032036] Subtest compare-crc-sanitycheck-xr24: SUCCESS (3.462s)
[460.748023] [116/162] (560s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[461.046022] Starting subtest: compare-crc-sanitycheck-nv12
[461.053653] Starting dynamic subtest: pipe-A-eDP-1
[462.683145] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.636s)
[462.699561] Starting dynamic subtest: pipe-B-DP-6
[463.367678] Dynamic subtest pipe-B-DP-6: SUCCESS (0.687s)
[463.386818] Starting dynamic subtest: pipe-C-DP-7
[464.013611] Dynamic subtest pipe-C-DP-7: SUCCESS (0.642s)
[464.027117] Starting dynamic subtest: pipe-D-DP-6
[464.661598] Dynamic subtest pipe-D-DP-6: SUCCESS (0.649s)
[464.667118] Subtest compare-crc-sanitycheck-nv12: SUCCESS (3.620s)
[465.440266] [117/162] (556s left) kms_pipe_crc_basic (hang-read-crc)
[465.803204] Starting subtest: hang-read-crc
[465.808435] Starting dynamic subtest: pipe-A-eDP-1
[468.810990] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.012s)
[468.825279] Starting dynamic subtest: pipe-B-DP-6
[470.547096] Dynamic subtest pipe-B-DP-6: SUCCESS (1.733s)
[470.562273] Starting dynamic subtest: pipe-C-DP-7
[472.186519] Dynamic subtest pipe-C-DP-7: SUCCESS (1.642s)
[472.204186] Starting dynamic subtest: pipe-D-DP-6
[473.826409] Dynamic subtest pipe-D-DP-6: SUCCESS (1.636s)
[473.835333] Subtest hang-read-crc: SUCCESS (8.030s)
[474.582713] [118/162] (547s left) kms_pipe_crc_basic (nonblocking-crc)
[474.880044] Starting subtest: nonblocking-crc
[474.885557] Starting dynamic subtest: pipe-A-eDP-1
[476.598719] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.721s)
[476.612996] Starting dynamic subtest: pipe-B-DP-6
[477.455510] Dynamic subtest pipe-B-DP-6: SUCCESS (0.855s)
[477.468141] Starting dynamic subtest: pipe-C-DP-7
[478.256544] Dynamic subtest pipe-C-DP-7: SUCCESS (0.800s)
[478.270052] Starting dynamic subtest: pipe-D-DP-6
[479.060311] Dynamic subtest pipe-D-DP-6: SUCCESS (0.802s)
[479.065719] Subtest nonblocking-crc: SUCCESS (4.184s)
[479.783671] [119/162] (541s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[480.090093] Starting subtest: nonblocking-crc-frame-sequence
[480.095822] Starting dynamic subtest: pipe-A-eDP-1
[481.786385] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.697s)
[481.801506] Starting dynamic subtest: pipe-B-DP-6
[482.634637] Dynamic subtest pipe-B-DP-6: SUCCESS (0.846s)
[482.647667] Starting dynamic subtest: pipe-C-DP-7
[483.454937] Dynamic subtest pipe-C-DP-7: SUCCESS (0.813s)
[483.469185] Starting dynamic subtest: pipe-D-DP-6
[484.262633] Dynamic subtest pipe-D-DP-6: SUCCESS (0.806s)
[484.268038] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.168s)
[485.088842] [120/162] (536s left) kms_pipe_crc_basic (read-crc)
[485.378440] Starting subtest: read-crc
[485.383974] Starting dynamic subtest: pipe-A-eDP-1
[487.005155] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.622s)
[487.019770] Starting dynamic subtest: pipe-B-DP-6
[487.789689] Dynamic subtest pipe-B-DP-6: SUCCESS (0.787s)
[487.802828] Starting dynamic subtest: pipe-C-DP-7
[488.549952] Dynamic subtest pipe-C-DP-7: SUCCESS (0.758s)
[488.562443] Starting dynamic subtest: pipe-D-DP-6
[489.284452] Dynamic subtest pipe-D-DP-6: SUCCESS (0.735s)
[489.292134] Subtest read-crc: SUCCESS (3.910s)
[490.120493] [121/162] (531s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[490.407871] Starting subtest: read-crc-frame-sequence
[490.413294] Starting dynamic subtest: pipe-A-eDP-1
[492.020575] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.606s)
[492.034859] Starting dynamic subtest: pipe-B-DP-6
[492.798467] Dynamic subtest pipe-B-DP-6: SUCCESS (0.782s)
[492.811040] Starting dynamic subtest: pipe-C-DP-7
[493.544113] Dynamic subtest pipe-C-DP-7: SUCCESS (0.740s)
[493.556785] Starting dynamic subtest: pipe-D-DP-6
[494.285416] Dynamic subtest pipe-D-DP-6: SUCCESS (0.741s)
[494.290998] Subtest read-crc-frame-sequence: SUCCESS (3.875s)
[495.122716] [122/162] (526s left) kms_pm_backlight (basic-brightness)
[495.408405] Starting subtest: basic-brightness
[495.810638] Starting dynamic subtest: eDP-1
[496.317799] Dynamic subtest eDP-1: SUCCESS (0.507s)
[496.323301] Subtest basic-brightness: SUCCESS (0.907s)
[497.555287] [123/162] (524s left) kms_pm_rpm (basic-pci-d3-state)
[501.230897] Starting subtest: basic-pci-d3-state
[502.814246] Subtest basic-pci-d3-state: SUCCESS (1.586s)
[503.389964] [124/162] (518s left) kms_pm_rpm (basic-rte)
[503.449279] Starting subtest: basic-rte
[508.621777] Subtest basic-rte: SUCCESS (5.184s)
[511.091606] [125/162] (510s left) kms_psr (psr-primary-page-flip)
[511.398138] Starting subtest: psr-primary-page-flip
[511.403521] Starting dynamic subtest: eDP-1
[513.570650] Dynamic subtest eDP-1: SUCCESS (2.174s)
[513.576568] Subtest psr-primary-page-flip: SUCCESS (2.175s)
[514.854048] [126/162] (507s left) kms_psr (psr-cursor-plane-move)
[515.145685] Starting subtest: psr-cursor-plane-move
[515.151211] Starting dynamic subtest: eDP-1
[517.316127] Dynamic subtest eDP-1: SUCCESS (2.165s)
[517.321613] Subtest psr-cursor-plane-move: SUCCESS (2.166s)
[518.590464] [127/162] (503s left) kms_psr (psr-sprite-plane-onoff)
[518.878310] Starting subtest: psr-sprite-plane-onoff
[518.883666] Starting dynamic subtest: eDP-1
[521.048712] Dynamic subtest eDP-1: SUCCESS (2.163s)
[521.054113] Subtest psr-sprite-plane-onoff: SUCCESS (2.164s)
[522.209604] [128/162] (499s left) kms_psr (psr-primary-mmap-gtt)
[522.511930] Starting subtest: psr-primary-mmap-gtt
[522.521266] Starting dynamic subtest: eDP-1
[524.318030] Dynamic subtest eDP-1: SKIP (1.800s)
[524.329010] Subtest psr-primary-mmap-gtt: SKIP (1.802s)
[524.838176] [129/162] (497s left) kms_setmode (basic-clone-single-crtc)
[524.906264] Starting subtest: basic-clone-single-crtc
[526.102283] Subtest basic-clone-single-crtc: SKIP (1.189s)
[526.935911] [130/162] (495s left) i915_pm_rps (basic-api)
[527.012936] Starting subtest: basic-api
[527.027200] Subtest basic-api: SKIP (0.001s)
[527.133118] [131/162] (495s left) prime_self_import (basic-llseek-bad)
[527.196090] Starting subtest: basic-llseek-bad
[527.209045] Subtest basic-llseek-bad: SUCCESS (0.022s)
[527.329109] [132/162] (495s left) prime_self_import (basic-llseek-size)
[527.381716] Starting subtest: basic-llseek-size
[527.392619] Subtest basic-llseek-size: SUCCESS (0.028s)
[527.518647] [133/162] (494s left) prime_self_import (basic-with_fd_dup)
[527.578463] Starting subtest: basic-with_fd_dup
[527.591216] Subtest basic-with_fd_dup: SUCCESS (0.025s)
[527.703866] [134/162] (494s left) prime_self_import (basic-with_one_bo)
[527.754043] Starting subtest: basic-with_one_bo
[527.774244] Subtest basic-with_one_bo: SUCCESS (0.025s)
[527.918344] [135/162] (494s left) prime_self_import (basic-with_one_bo_two_files)
[527.978512] Starting subtest: basic-with_one_bo_two_files
[527.991638] Subtest basic-with_one_bo_two_files: SUCCESS (0.016s)
[528.104232] [136/162] (494s left) prime_self_import (basic-with_two_bos)
[528.161726] Starting subtest: basic-with_two_bos
[528.175816] Subtest basic-with_two_bos: SUCCESS (0.016s)
[528.287347] [137/162] (494s left) prime_vgem (basic-fence-flip)
[528.365832] Starting subtest: basic-fence-flip
[528.874980] Subtest basic-fence-flip: SUCCESS (0.514s)
[529.022075] [138/162] (493s left) prime_vgem (basic-fence-mmap)
[529.112189] Starting subtest: basic-fence-mmap
[529.122962] Subtest basic-fence-mmap: SKIP (0.000s)
[529.241097] [139/162] (493s left) prime_vgem (basic-fence-read)
[529.323390] Starting subtest: basic-fence-read
[529.334346] Subtest basic-fence-read: SKIP (0.006s)
[529.454680] [140/162] (493s left) prime_vgem (basic-gtt)
[529.535568] Starting subtest: basic-gtt
[529.546357] Subtest basic-gtt: SKIP (0.000s)
[529.660196] [141/162] (493s left) prime_vgem (basic-read)
[529.735562] Starting subtest: basic-read
[529.746254] Subtest basic-read: SKIP (0.005s)
[529.862792] [142/162] (493s left) prime_vgem (basic-write)
[529.942071] Starting subtest: basic-write
[529.952873] Subtest basic-write: SKIP (0.004s)
[530.068526] [143/162] (492s left) vgem_basic (setversion)
[530.138029] Starting subtest: setversion
[530.148864] Subtest setversion: SUCCESS (0.000s)
[530.197977] [144/162] (492s left) vgem_basic (create)
[530.257671] Starting subtest: create
[530.263063] Subtest create: SUCCESS (0.000s)
[530.332105] [145/162] (492s left) vgem_basic (debugfs)
[530.393886] Starting subtest: debugfs
[530.399261] Subtest debugfs: SUCCESS (0.000s)
[530.465972] [146/162] (492s left) vgem_basic (dmabuf-export)
[530.524388] Starting subtest: dmabuf-export
[530.554775] Subtest dmabuf-export: SUCCESS (0.031s)
[530.661015] [147/162] (492s left) vgem_basic (dmabuf-fence)
[530.724886] Starting subtest: dmabuf-fence
[530.730297] Subtest dmabuf-fence: SUCCESS (0.000s)
[530.800269] [148/162] (492s left) vgem_basic (dmabuf-fence-before)
[530.862615] Starting subtest: dmabuf-fence-before
[530.868090] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[530.932511] [149/162] (492s left) vgem_basic (dmabuf-mmap)
[530.996319] Starting subtest: dmabuf-mmap
[531.001819] Subtest dmabuf-mmap: SUCCESS (0.008s)
[531.069732] [150/162] (492s left) vgem_basic (mmap)
[531.128318] Starting subtest: mmap
[531.133716] Subtest mmap: SUCCESS (0.005s)
[531.192581] [151/162] (492s left) vgem_basic (second-client)
[531.246026] Starting subtest: second-client
[531.276552] Subtest second-client: SUCCESS (0.032s)
[531.347900] [152/162] (491s left) vgem_basic (sysfs)
[531.409554] Starting subtest: sysfs
[531.416690] Subtest sysfs: SUCCESS (0.000s)
[531.478932] [153/162] (491s left) core_hotunplug (unbind-rebind)
[531.588332] Starting subtest: unbind-rebind
[538.176554] Subtest unbind-rebind: SUCCESS (6.589s)
[538.242229] [154/162] (485s left) vgem_basic (unload)
[538.298374] Starting subtest: unload
[567.341728] Subtest unload: SUCCESS (29.046s)
[567.447970] [155/162] (456s left) i915_module_load (reload)
[567.497874] Starting subtest: reload
[571.865952] Subtest reload: SUCCESS (4.376s)
[571.918763] [156/162] (451s left) gem_lmem_swapping (basic)
[571.985049] Subtest basic: SKIP (0.000s)
[572.050810] [157/162] (451s left) gem_lmem_swapping (parallel-random-engines)
[572.120097] Subtest parallel-random-engines: SKIP (0.000s)
[572.168135] [158/162] (451s left) gem_lmem_swapping (random-engines)
[572.231283] Subtest random-engines: SKIP (0.000s)
[572.281758] [159/162] (451s left) gem_lmem_swapping (verify-random)
[572.352577] Subtest verify-random: SKIP (0.000s)
[572.406044] [160/162] (451s left) i915_pm_rpm (module-reload)
[577.083481] Starting subtest: module-reload
[594.835521] Subtest module-reload: SUCCESS (17.747s)
[594.873159] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[594.873882] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true
[594.880237] [161/162] (428s left) i915_selftest (live)
[594.924640] Starting subtest: live
[594.930309] Starting dynamic subtest: sanitycheck
[599.253998] Dynamic subtest sanitycheck: SUCCESS (4.324s)
[599.264957] Starting dynamic subtest: uncore
[603.576433] Dynamic subtest uncore: SUCCESS (4.321s)
[603.588478] Starting dynamic subtest: workarounds
[606.605117] Dynamic subtest workarounds: SUCCESS (3.027s)
[606.617503] Starting dynamic subtest: gt_engines
[611.036268] Dynamic subtest gt_engines: SUCCESS (4.430s)
[611.048850] Starting dynamic subtest: gt_timelines
[624.408923] Dynamic subtest gt_timelines: SUCCESS (13.370s)
[624.421583] Starting dynamic subtest: gt_contexts
[628.743371] Dynamic subtest gt_contexts: SUCCESS (4.341s)
[628.759871] Starting dynamic subtest: gt_lrc
[634.856298] Dynamic subtest gt_lrc: SUCCESS (6.103s)
[634.868581] Starting dynamic subtest: gt_mocs
[637.779235] Dynamic subtest gt_mocs: SUCCESS (2.920s)
[637.789898] Starting dynamic subtest: gt_pm
[644.529334] Dynamic subtest gt_pm: SUCCESS (6.748s)
[644.543600] Starting dynamic subtest: gt_heartbeat
[648.857648] Dynamic subtest gt_heartbeat: SUCCESS (4.327s)
[648.870292] Starting dynamic subtest: gt_tlb
[658.650643] Dynamic subtest gt_tlb: SUCCESS (9.791s)
[658.661523] Starting dynamic subtest: requests
[672.052342] Dynamic subtest requests: SUCCESS (13.396s)
[672.065034] Starting dynamic subtest: migrate
[679.748328] Dynamic subtest migrate: SUCCESS (7.694s)
[679.765479] Starting dynamic subtest: active
[684.086768] Dynamic subtest active: SUCCESS (4.339s)
[684.099342] Starting dynamic subtest: objects
[688.895873] Dynamic subtest objects: SUCCESS (4.806s)
[688.908142] Starting dynamic subtest: mman
[693.628547] Dynamic subtest mman: SUCCESS (4.732s)
[693.641088] Starting dynamic subtest: dmabuf
[697.994135] Dynamic subtest dmabuf: SUCCESS (4.360s)
[698.009531] Starting dynamic subtest: vma
[702.330129] Dynamic subtest vma: SUCCESS (4.338s)
[702.342747] Starting dynamic subtest: coherency
[707.234355] Dynamic subtest coherency: SUCCESS (4.902s)
[707.246778] Starting dynamic subtest: gtt
[718.870475] Dynamic subtest gtt: SUCCESS (11.634s)
[718.883159] Starting dynamic subtest: gem
[726.965235] Dynamic subtest gem: SUCCESS (8.093s)
[726.977911] Starting dynamic subtest: evict
[732.409579] Dynamic subtest evict: SUCCESS (5.443s)
[732.422970] Starting dynamic subtest: hugepages
[743.676265] Dynamic subtest hugepages: SUCCESS (11.265s)
[743.687439] Starting dynamic subtest: gem_contexts
[769.230543] Dynamic subtest gem_contexts: SUCCESS (25.551s)
[769.243526] Starting dynamic subtest: client
[773.531106] Dynamic subtest client: SUCCESS (4.299s)
[773.543894] Starting dynamic subtest: gem_migrate
[777.828101] Dynamic subtest gem_migrate: SUCCESS (4.295s)
[777.840959] Starting dynamic subtest: reset
[780.568918] Dynamic subtest reset: SUCCESS (2.739s)
[780.582060] Starting dynamic subtest: memory_region
[784.928529] Dynamic subtest memory_region: SUCCESS (4.358s)
[784.940020] Starting dynamic subtest: hangcheck
[798.632741] Dynamic subtest hangcheck: SUCCESS (13.702s)
[798.645208] Starting dynamic subtest: execlists
[802.912277] Dynamic subtest execlists: SUCCESS (4.278s)
[802.925132] Starting dynamic subtest: ring_submission
[807.193716] Dynamic subtest ring_submission: SUCCESS (4.276s)
[807.209222] Starting dynamic subtest: perf
[811.515426] Dynamic subtest perf: SUCCESS (4.323s)
[811.527998] Starting dynamic subtest: slpc
[826.056028] Dynamic subtest slpc: SUCCESS (14.538s)
[826.068888] Starting dynamic subtest: guc
[829.899973] Dynamic subtest guc: SUCCESS (3.842s)
[829.913053] Starting dynamic subtest: guc_multi_lrc
[832.578945] Dynamic subtest guc_multi_lrc: SUCCESS (2.678s)
[832.591657] Starting dynamic subtest: guc_hang
[837.426300] Dynamic subtest guc_hang: SUCCESS (4.846s)
[837.438768] Starting dynamic subtest: late_gt_pm
[841.748237] Dynamic subtest late_gt_pm: SUCCESS (4.325s)
[841.754090] Subtest live: SUCCESS (246.811s)
[841.801504] [162/162] (182s left) dmabuf (all-tests)
[841.861016] Starting subtest: all-tests
[841.869397] Starting dynamic subtest: sanitycheck
[841.938255] Dynamic subtest sanitycheck: SUCCESS (0.080s)
[841.949678] Starting dynamic subtest: dma_fence
[842.130104] Dynamic subtest dma_fence: SUCCESS (0.189s)
[842.146143] Starting dynamic subtest: dma_fence_chain
[851.148165] Dynamic subtest dma_fence_chain: SUCCESS (9.012s)
[851.161566] Starting dynamic subtest: dma_fence_unwrap
[851.242285] Dynamic subtest dma_fence_unwrap: SUCCESS (0.100s)
[851.254797] Starting dynamic subtest: dma_resv
[851.332981] Dynamic subtest dma_resv: SUCCESS (0.088s)
[851.340671] Subtest all-tests: SUCCESS (9.478s)
[851.373661] Closing watchdogs
results: parsing output: 0/ for test: i915_module_load
results: parsing output: 1/ for test: core_auth
results: parsing output: 2/ for test: core_debugfs
results: parsing output: 3/ for test: core_sysfs
results: parsing output: 4/ for test: fbdev
results: parsing output: 5/ for test: fbdev
results: parsing output: 6/ for test: fbdev
results: parsing output: 7/ for test: fbdev
results: parsing output: 8/ for test: fbdev
results: parsing output: 9/ for test: gem_basic
results: parsing output: 10/ for test: gem_basic
results: parsing output: 11/ for test: gem_basic
results: parsing output: 12/ for test: gem_busy
results: parsing output: 13/ for test: gem_close_race
results: parsing output: 14/ for test: gem_close_race
results: parsing output: 15/ for test: gem_ctx_create
results: parsing output: 16/ for test: gem_ctx_create
results: parsing output: 17/ for test: gem_ctx_exec
results: parsing output: 18/ for test: gem_exec_basic
results: parsing output: 19/ for test: gem_exec_create
results: parsing output: 20/ for test: gem_exec_fence
results: parsing output: 21/ for test: gem_exec_fence
results: parsing output: 22/ for test: gem_exec_fence
results: parsing output: 23/ for test: gem_exec_fence
results: parsing output: 24/ for test: gem_exec_gttfill
results: parsing output: 25/ for test: gem_exec_parallel
results: parsing output: 26/ for test: gem_exec_store
results: parsing output: 27/ for test: gem_flink_basic
results: parsing output: 28/ for test: gem_flink_basic
results: parsing output: 29/ for test: gem_flink_basic
results: parsing output: 30/ for test: gem_flink_basic
results: parsing output: 31/ for test: gem_flink_basic
results: parsing output: 32/ for test: gem_huc_copy
results: parsing output: 33/ for test: gem_linear_blits
results: parsing output: 34/ for test: gem_mmap
results: parsing output: 35/ for test: gem_mmap_gtt
results: parsing output: 36/ for test: gem_render_linear_blits
results: parsing output: 37/ for test: gem_render_tiled_blits
results: parsing output: 38/ for test: gem_ringfill
results: parsing output: 39/ for test: gem_softpin
results: parsing output: 40/ for test: gem_softpin
results: parsing output: 41/ for test: gem_softpin
results: parsing output: 42/ for test: gem_sync
results: parsing output: 43/ for test: gem_sync
results: parsing output: 44/ for test: gem_tiled_blits
results: parsing output: 45/ for test: gem_tiled_fence_blits
results: parsing output: 46/ for test: gem_tiled_pread_basic
results: parsing output: 47/ for test: gem_wait
results: parsing output: 48/ for test: gem_wait
results: parsing output: 49/ for test: i915_getparams_basic
results: parsing output: 50/ for test: i915_getparams_basic
results: parsing output: 51/ for test: i915_hangman
results: parsing output: 52/ for test: i915_pciid
results: parsing output: 53/ for test: intel_hwmon
results: parsing output: 54/ for test: intel_hwmon
results: parsing output: 55/ for test: kms_addfb_basic
results: parsing output: 56/ for test: kms_addfb_basic
results: parsing output: 57/ for test: kms_addfb_basic
results: parsing output: 58/ for test: kms_addfb_basic
results: parsing output: 59/ for test: kms_addfb_basic
results: parsing output: 60/ for test: kms_addfb_basic
results: parsing output: 61/ for test: kms_addfb_basic
results: parsing output: 62/ for test: kms_addfb_basic
results: parsing output: 63/ for test: kms_addfb_basic
results: parsing output: 64/ for test: kms_addfb_basic
results: parsing output: 65/ for test: kms_addfb_basic
results: parsing output: 66/ for test: kms_addfb_basic
results: parsing output: 67/ for test: kms_addfb_basic
results: parsing output: 68/ for test: kms_addfb_basic
results: parsing output: 69/ for test: kms_addfb_basic
results: parsing output: 70/ for test: kms_addfb_basic
results: parsing output: 71/ for test: kms_addfb_basic
results: parsing output: 72/ for test: kms_addfb_basic
results: parsing output: 73/ for test: kms_addfb_basic
results: parsing output: 74/ for test: kms_addfb_basic
results: parsing output: 75/ for test: kms_addfb_basic
results: parsing output: 76/ for test: kms_addfb_basic
results: parsing output: 77/ for test: kms_addfb_basic
results: parsing output: 78/ for test: kms_addfb_basic
results: parsing output: 79/ for test: kms_addfb_basic
results: parsing output: 80/ for test: kms_addfb_basic
results: parsing output: 81/ for test: kms_addfb_basic
results: parsing output: 82/ for test: kms_addfb_basic
results: parsing output: 83/ for test: kms_addfb_basic
results: parsing output: 84/ for test: kms_addfb_basic
results: parsing output: 85/ for test: kms_addfb_basic
results: parsing output: 86/ for test: kms_addfb_basic
results: parsing output: 87/ for test: kms_addfb_basic
results: parsing output: 88/ for test: kms_addfb_basic
results: parsing output: 89/ for test: kms_addfb_basic
results: parsing output: 90/ for test: kms_addfb_basic
results: parsing output: 91/ for test: kms_addfb_basic
results: parsing output: 92/ for test: kms_addfb_basic
results: parsing output: 93/ for test: kms_busy
results: parsing output: 94/ for test: kms_prop_blob
results: parsing output: 95/ for test: kms_cursor_legacy
results: parsing output: 96/ for test: kms_cursor_legacy
results: parsing output: 97/ for test: kms_cursor_legacy
results: parsing output: 98/ for test: kms_cursor_legacy
results: parsing output: 99/ for test: kms_cursor_legacy
results: parsing output: 100/ for test: kms_cursor_legacy
results: parsing output: 101/ for test: kms_cursor_legacy
results: parsing output: 102/ for test: kms_cursor_legacy
results: parsing output: 103/ for test: kms_dsc
results: parsing output: 104/ for test: kms_flip
results: parsing output: 105/ for test: kms_flip
results: parsing output: 106/ for test: kms_flip
results: parsing output: 107/ for test: kms_flip
results: parsing output: 108/ for test: kms_force_connector_basic
results: parsing output: 109/ for test: kms_force_connector_basic
results: parsing output: 110/ for test: kms_force_connector_basic
results: parsing output: 111/ for test: kms_force_connector_basic
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_hdmi_inject
results: parsing output: 114/ for test: kms_pipe_crc_basic
results: parsing output: 115/ for test: kms_pipe_crc_basic
results: parsing output: 116/ for test: kms_pipe_crc_basic
results: parsing output: 117/ for test: kms_pipe_crc_basic
results: parsing output: 118/ for test: kms_pipe_crc_basic
results: parsing output: 119/ for test: kms_pipe_crc_basic
results: parsing output: 120/ for test: kms_pipe_crc_basic
results: parsing output: 121/ for test: kms_pm_backlight
results: parsing output: 122/ for test: kms_pm_rpm
results: parsing output: 123/ for test: kms_pm_rpm
results: parsing output: 124/ for test: kms_psr
results: parsing output: 125/ for test: kms_psr
results: parsing output: 126/ for test: kms_psr
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: kms_setmode
results: parsing output: 129/ for test: i915_pm_rps
results: parsing output: 130/ for test: prime_self_import
results: parsing output: 131/ for test: prime_self_import
results: parsing output: 132/ for test: prime_self_import
results: parsing output: 133/ for test: prime_self_import
results: parsing output: 134/ for test: prime_self_import
results: parsing output: 135/ for test: prime_self_import
results: parsing output: 136/ for test: prime_vgem
results: parsing output: 137/ for test: prime_vgem
results: parsing output: 138/ for test: prime_vgem
results: parsing output: 139/ for test: prime_vgem
results: parsing output: 140/ for test: prime_vgem
results: parsing output: 141/ for test: prime_vgem
results: parsing output: 142/ for test: vgem_basic
results: parsing output: 143/ for test: vgem_basic
results: parsing output: 144/ for test: vgem_basic
results: parsing output: 145/ for test: vgem_basic
results: parsing output: 146/ for test: vgem_basic
results: parsing output: 147/ for test: vgem_basic
results: parsing output: 148/ for test: vgem_basic
results: parsing output: 149/ for test: vgem_basic
results: parsing output: 150/ for test: vgem_basic
results: parsing output: 151/ for test: vgem_basic
results: parsing output: 152/ for test: core_hotunplug
results: parsing output: 153/ for test: vgem_basic
results: parsing output: 154/ for test: i915_module_load
results: parsing output: 155/ for test: gem_lmem_swapping
results: parsing output: 156/ for test: gem_lmem_swapping
results: parsing output: 157/ for test: gem_lmem_swapping
results: parsing output: 158/ for test: gem_lmem_swapping
results: parsing output: 159/ for test: i915_pm_rpm
results: parsing output: 160/ for test: i915_selftest
results: parsing output: 161/ for test: dmabuf
Done.