[40.369140] Initializing watchdogs
[40.369309]   /dev/watchdog0
[40.410651] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:4e51 Intel Jasperlake (Gen11) 
[40.422656] [001/161] (960s left) i915_module_load (load)
[40.537806] Starting subtest: load
[45.087268] Subtest load: SUCCESS (4.542s)
[45.167294] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[45.171065] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[45.178292] [002/161] (955s left) core_auth (basic-auth)
[45.291467] Starting subtest: basic-auth
[45.294246] Subtest basic-auth: SUCCESS (0.002s)
[45.454986] [003/161] (955s left) debugfs_test (read_all_entries)
[45.572864] Starting subtest: read_all_entries
[45.682714] Subtest read_all_entries: SUCCESS (0.109s)
[45.916627] [004/161] (955s left) debugfs_test (basic-hwmon)
[46.071152] Starting subtest: basic-hwmon
[46.077300] Subtest basic-hwmon: SKIP (0.000s)
[46.284452] [005/161] (955s left) debugfs_test (sysfs)
[46.393192] Starting subtest: sysfs
[46.506202] Subtest sysfs: SUCCESS (0.113s)
[46.738609] [006/161] (954s left) fbdev (eof)
[46.847268] Starting subtest: eof
[46.849486] Subtest eof: SUCCESS (0.001s)
[46.964256] [007/161] (954s left) fbdev (info)
[47.068383] Starting subtest: info
[47.070143] Subtest info: SUCCESS (0.000s)
[47.201564] [008/161] (954s left) fbdev (nullptr)
[47.312067] Starting subtest: nullptr
[47.314203] Subtest nullptr: SUCCESS (0.000s)
[47.430799] [009/161] (954s left) fbdev (read)
[47.545671] Starting subtest: read
[54.337083] Subtest read: SUCCESS (6.790s)
[54.470115] [010/161] (947s left) fbdev (write)
[54.580345] Starting subtest: write
[58.048912] Subtest write: SUCCESS (3.496s)
[58.165706] [011/161] (943s left) gem_basic (bad-close)
[58.269894] Starting subtest: bad-close
[58.274744] Subtest bad-close: SUCCESS (0.000s)
[58.393523] [012/161] (943s left) gem_basic (create-close)
[58.491249] Starting subtest: create-close
[58.495554] Subtest create-close: SUCCESS (0.000s)
[58.653755] [013/161] (943s left) gem_basic (create-fd-close)
[58.757054] Starting subtest: create-fd-close
[58.761238] Subtest create-fd-close: SUCCESS (0.000s)
[58.912239] [014/161] (943s left) gem_busy (busy@all-engines)
[59.037410] Starting subtest: busy
[59.039865] Starting dynamic subtest: all-engines
[59.124230] Dynamic subtest all-engines: SUCCESS (0.090s)
[59.126323] Subtest busy: SUCCESS (0.091s)
[59.579474] [015/161] (942s left) gem_close_race (basic-process)
[59.709670] Starting subtest: basic-process
[59.813289] Subtest basic-process: SUCCESS (0.106s)
[60.064948] [016/161] (942s left) gem_close_race (basic-threads)
[60.194159] Starting subtest: basic-threads
[61.468837] Subtest basic-threads: SUCCESS (1.305s)
[61.754308] [017/161] (940s left) gem_ctx_create (basic)
[61.883212] Starting subtest: basic
[61.885230] Subtest basic: SUCCESS (0.000s)
[62.136077] [018/161] (940s left) gem_ctx_create (basic-files)
[62.260651] Starting subtest: basic-files
[64.292725] Subtest basic-files: SUCCESS (2.069s)
[64.590127] [019/161] (937s left) gem_ctx_exec (basic)
[64.693340] Starting subtest: basic
[64.698516] Subtest basic: SUCCESS (0.005s)
[64.867510] [020/161] (937s left) gem_exec_basic (basic)
[64.988112] Starting subtest: basic
[64.990657] Starting dynamic subtest: rcs0-smem
[64.993195] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[65.009624] Starting dynamic subtest: bcs0-smem
[65.011970] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[65.027903] Starting dynamic subtest: vcs0-smem
[65.030281] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[65.046155] Starting dynamic subtest: vecs0-smem
[65.048509] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[65.050814] Subtest basic: SUCCESS (0.008s)
[65.247901] [021/161] (937s left) gem_exec_create (basic)
[65.375742] Starting subtest: basic
[65.377938] Starting dynamic subtest: smem
[67.424327] Dynamic subtest smem: SUCCESS (2.070s)
[67.426694] Subtest basic: SUCCESS (2.070s)
[67.719263] [022/161] (934s left) gem_exec_fence (basic-busy)
[67.985697] Starting subtest: basic-busy
[67.988341] Starting dynamic subtest: rcs0
[68.010482] Dynamic subtest rcs0: SUCCESS (0.025s)
[68.028770] Starting dynamic subtest: bcs0
[68.036738] Dynamic subtest bcs0: SUCCESS (0.025s)
[68.054425] Starting dynamic subtest: vcs0
[68.062616] Dynamic subtest vcs0: SUCCESS (0.027s)
[68.079477] Starting dynamic subtest: vecs0
[68.092397] Dynamic subtest vecs0: SUCCESS (0.030s)
[68.094850] Subtest basic-busy: SUCCESS (0.108s)
[68.779551] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[68.784960] [023/161] (933s left) gem_exec_fence (basic-wait)
[69.048594] Starting subtest: basic-wait
[69.050764] Starting dynamic subtest: rcs0
[69.078171] Dynamic subtest rcs0: SUCCESS (0.030s)
[69.095907] Starting dynamic subtest: bcs0
[69.102778] Dynamic subtest bcs0: SUCCESS (0.025s)
[69.121046] Starting dynamic subtest: vcs0
[69.127636] Dynamic subtest vcs0: SUCCESS (0.025s)
[69.145186] Starting dynamic subtest: vecs0
[69.161753] Dynamic subtest vecs0: SUCCESS (0.034s)
[69.164591] Subtest basic-wait: SUCCESS (0.115s)
[69.795907] [024/161] (932s left) gem_exec_fence (basic-await)
[70.049121] Starting subtest: basic-await
[70.051680] Starting dynamic subtest: rcs0
[70.176534] Dynamic subtest rcs0: SUCCESS (0.125s)
[70.214804] Starting dynamic subtest: bcs0
[70.322479] Dynamic subtest bcs0: SUCCESS (0.146s)
[70.360350] Starting dynamic subtest: vcs0
[70.465532] Dynamic subtest vcs0: SUCCESS (0.143s)
[70.504740] Starting dynamic subtest: vecs0
[70.609962] Dynamic subtest vecs0: SUCCESS (0.144s)
[70.614331] Subtest basic-await: SUCCESS (0.564s)
[71.256957] [025/161] (931s left) gem_exec_fence (nb-await)
[71.514865] Starting subtest: nb-await
[71.517453] Starting dynamic subtest: rcs0
[71.585024] Dynamic subtest rcs0: SUCCESS (0.069s)
[71.606071] Starting dynamic subtest: bcs0
[71.650568] Dynamic subtest bcs0: SUCCESS (0.064s)
[71.670841] Starting dynamic subtest: vcs0
[71.714030] Dynamic subtest vcs0: SUCCESS (0.065s)
[71.732960] Starting dynamic subtest: vecs0
[71.780872] Dynamic subtest vecs0: SUCCESS (0.063s)
[71.789187] Subtest nb-await: SUCCESS (0.263s)
[73.252784] [026/161] (929s left) gem_exec_gttfill (basic)
[73.464460] Starting subtest: basic
[86.272460] Subtest basic: SUCCESS (12.838s)
[86.541758] [027/161] (916s left) gem_exec_parallel (engines)
[86.737037] Starting subtest: engines
[86.739103] Starting dynamic subtest: basic
[89.382692] Dynamic subtest basic: SUCCESS (2.648s)
[89.402737] Starting dynamic subtest: contexts
[96.849832] Dynamic subtest contexts: SUCCESS (7.465s)
[96.878994] Starting dynamic subtest: fds
[107.052696] Dynamic subtest fds: SUCCESS (10.201s)
[107.097532] Starting dynamic subtest: userptr
[110.393960] Dynamic subtest userptr: SUCCESS (3.341s)
[110.396871] Subtest engines: SUCCESS (23.657s)
[110.697928] [028/161] (892s left) gem_exec_store (basic)
[110.824033] Starting subtest: basic
[110.896025] Subtest basic: SUCCESS (0.072s)
[111.164217] [029/161] (892s left) gem_flink_basic (bad-flink)
[111.269946] Starting subtest: bad-flink
[111.272489] Subtest bad-flink: SUCCESS (0.000s)
[111.415410] [030/161] (892s left) gem_flink_basic (bad-open)
[111.522370] Starting subtest: bad-open
[111.524679] Subtest bad-open: SUCCESS (0.000s)
[111.663811] [031/161] (891s left) gem_flink_basic (basic)
[111.768638] Starting subtest: basic
[111.770956] Subtest basic: SUCCESS (0.000s)
[111.929777] [032/161] (891s left) gem_flink_basic (double-flink)
[112.036407] Starting subtest: double-flink
[112.038732] Subtest double-flink: SUCCESS (0.000s)
[112.196269] [033/161] (891s left) gem_flink_basic (flink-lifetime)
[112.299405] Starting subtest: flink-lifetime
[112.301611] Subtest flink-lifetime: SUCCESS (0.002s)
[112.462873] [034/161] (891s left) gem_huc_copy (huc-copy)
[112.576642] Starting subtest: huc-copy
[112.581154] Subtest huc-copy: SKIP (0.000s)
[112.746277] [035/161] (891s left) gem_linear_blits (basic)
[113.011675] Starting subtest: basic
[113.031680] Subtest basic: SUCCESS (0.020s)
[113.257958] [036/161] (890s left) gem_mmap (basic)
[113.422269] Starting subtest: basic
[113.431246] Subtest basic: SUCCESS (0.001s)
[113.596926] [037/161] (890s left) gem_mmap_gtt (basic)
[113.698498] Starting subtest: basic
[113.700701] Subtest basic: SUCCESS (0.001s)
[113.844018] [038/161] (890s left) gem_render_linear_blits (basic)
[113.957484] Starting subtest: basic
[114.014405] Subtest basic: SUCCESS (0.057s)
[114.146587] [039/161] (890s left) gem_render_tiled_blits (basic)
[114.258246] Starting subtest: basic
[114.322261] Subtest basic: SUCCESS (0.066s)
[114.443549] [040/161] (889s left) gem_ringfill (basic-all)
[114.697240] Starting subtest: basic-all
[115.931365] Subtest basic-all: SUCCESS (1.231s)
[116.083944] [041/161] (888s left) gem_softpin (allocator-basic)
[116.195943] Starting subtest: allocator-basic
[116.371646] Subtest allocator-basic: SUCCESS (0.174s)
[116.610526] [042/161] (888s left) gem_softpin (allocator-basic-reserve)
[116.722863] Starting subtest: allocator-basic-reserve
[116.900213] Subtest allocator-basic-reserve: SUCCESS (0.176s)
[117.065300] [043/161] (887s left) gem_softpin (safe-alignment)
[117.177087] Starting subtest: safe-alignment
[117.196582] Subtest safe-alignment: SUCCESS (0.019s)
[117.385195] [044/161] (887s left) gem_sync (basic-all)
[117.518457] Starting subtest: basic-all
[119.986616] Subtest basic-all: SUCCESS (2.470s)
[120.250120] [045/161] (884s left) gem_sync (basic-each)
[120.376721] Starting subtest: basic-each
[122.756274] Subtest basic-each: SUCCESS (2.380s)
[123.061822] [046/161] (881s left) gem_tiled_blits (basic)
[123.261726] Starting subtest: basic
[123.295662] Subtest basic: SUCCESS (0.034s)
[123.532976] [047/161] (881s left) gem_tiled_fence_blits (basic)
[123.822596] Starting subtest: basic
[123.852691] Subtest basic: SUCCESS (0.030s)
[124.066226] [048/161] (881s left) gem_tiled_pread_basic
[124.680541] [049/161] (880s left) gem_wait (busy@all-engines)
[124.821532] Starting subtest: busy
[124.823936] Starting dynamic subtest: all-engines
[125.351515] Dynamic subtest all-engines: SUCCESS (0.530s)
[125.354038] Subtest busy: SUCCESS (0.531s)
[125.669272] [050/161] (879s left) gem_wait (wait@all-engines)
[125.809176] Starting subtest: wait
[125.811715] Starting dynamic subtest: all-engines
[126.851033] Dynamic subtest all-engines: SUCCESS (1.041s)
[126.854267] Subtest wait: SUCCESS (1.042s)
[127.166677] [051/161] (878s left) i915_getparams_basic (basic-eu-total)
[127.273729] Starting subtest: basic-eu-total
[127.280886] Subtest basic-eu-total: SUCCESS (0.000s)
[127.414204] [052/161] (878s left) i915_getparams_basic (basic-subslice-total)
[127.516740] Starting subtest: basic-subslice-total
[127.521708] Subtest basic-subslice-total: SUCCESS (0.000s)
[127.664945] [053/161] (878s left) i915_hangman (error-state-basic)
[127.792379] Starting subtest: error-state-basic
[127.804561] Subtest error-state-basic: SUCCESS (0.012s)
[127.944994] [054/161] (877s left) i915_pciid
[128.198320] [055/161] (877s left) kms_addfb_basic (addfb25-4-tiled)
[128.365892] Starting subtest: addfb25-4-tiled
[128.368043] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[128.533147] [056/161] (877s left) kms_addfb_basic (addfb25-bad-modifier)
[128.690691] Starting subtest: addfb25-bad-modifier
[128.693116] Subtest addfb25-bad-modifier: SUCCESS (0.001s)
[128.870035] [057/161] (877s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[129.026164] Starting subtest: addfb25-framebuffer-vs-set-tiling
[129.028330] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[129.202883] [058/161] (876s left) kms_addfb_basic (addfb25-modifier-no-flag)
[129.357951] Starting subtest: addfb25-modifier-no-flag
[129.360206] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[129.529957] [059/161] (876s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[129.685262] Starting subtest: addfb25-x-tiled-legacy
[129.687445] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[129.858053] [060/161] (876s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[130.026739] Starting subtest: addfb25-x-tiled-mismatch-legacy
[130.028971] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[130.245552] [061/161] (876s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[130.404212] Starting subtest: addfb25-yf-tiled-legacy
[130.406249] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[130.570980] [062/161] (876s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[130.731133] Starting subtest: addfb25-y-tiled-legacy
[130.733130] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[130.906414] [063/161] (875s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[131.066299] Starting subtest: addfb25-y-tiled-small-legacy
[131.068719] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s)
[131.249184] [064/161] (875s left) kms_addfb_basic (bad-pitch-0)
[131.352768] Starting subtest: bad-pitch-0
[131.355187] Subtest bad-pitch-0: SUCCESS (0.000s)
[131.599285] [065/161] (875s left) kms_addfb_basic (bad-pitch-1024)
[131.704693] Starting subtest: bad-pitch-1024
[131.706854] Subtest bad-pitch-1024: SUCCESS (0.000s)
[131.917903] [066/161] (875s left) kms_addfb_basic (bad-pitch-128)
[132.020134] Starting subtest: bad-pitch-128
[132.021952] Subtest bad-pitch-128: SUCCESS (0.000s)
[132.280157] [067/161] (874s left) kms_addfb_basic (bad-pitch-256)
[132.385709] Starting subtest: bad-pitch-256
[132.387520] Subtest bad-pitch-256: SUCCESS (0.000s)
[132.617428] [068/161] (874s left) kms_addfb_basic (bad-pitch-32)
[132.720520] Starting subtest: bad-pitch-32
[132.722572] Subtest bad-pitch-32: SUCCESS (0.000s)
[132.931503] [069/161] (874s left) kms_addfb_basic (bad-pitch-63)
[133.036081] Starting subtest: bad-pitch-63
[133.037846] Subtest bad-pitch-63: SUCCESS (0.000s)
[133.261052] [070/161] (874s left) kms_addfb_basic (bad-pitch-65536)
[133.367411] Starting subtest: bad-pitch-65536
[133.369602] Subtest bad-pitch-65536: SUCCESS (0.000s)
[133.584047] [071/161] (873s left) kms_addfb_basic (bad-pitch-999)
[133.687343] Starting subtest: bad-pitch-999
[133.689521] Subtest bad-pitch-999: SUCCESS (0.000s)
[133.922147] [072/161] (873s left) kms_addfb_basic (basic)
[134.026501] Starting subtest: basic
[134.028276] Subtest basic: SUCCESS (0.000s)
[134.254409] [073/161] (873s left) kms_addfb_basic (basic-x-tiled-legacy)
[134.358516] Starting subtest: basic-x-tiled-legacy
[134.360551] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[134.582785] [074/161] (873s left) kms_addfb_basic (basic-y-tiled-legacy)
[134.689081] Starting subtest: basic-y-tiled-legacy
[134.690845] Subtest basic-y-tiled-legacy: SUCCESS (0.001s)
[134.904656] [075/161] (872s left) kms_addfb_basic (bo-too-small)
[135.061581] Starting subtest: bo-too-small
[135.063850] Subtest bo-too-small: SUCCESS (0.001s)
[135.240296] [076/161] (872s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[135.394948] Starting subtest: bo-too-small-due-to-tiling
[135.397304] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s)
[135.574584] [077/161] (872s left) kms_addfb_basic (clobberred-modifier)
[135.677534] Starting subtest: clobberred-modifier
[135.679745] Subtest clobberred-modifier: SUCCESS (0.000s)
[135.915148] [078/161] (872s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[136.020981] Starting subtest: framebuffer-vs-set-tiling
[136.023058] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[136.233916] [079/161] (872s left) kms_addfb_basic (invalid-get-prop)
[136.337574] Starting subtest: invalid-get-prop
[136.339759] Subtest invalid-get-prop: SUCCESS (0.000s)
[136.582177] [080/161] (871s left) kms_addfb_basic (invalid-get-prop-any)
[136.686890] Starting subtest: invalid-get-prop-any
[136.689133] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[136.911385] [081/161] (871s left) kms_addfb_basic (invalid-set-prop)
[137.014933] Starting subtest: invalid-set-prop
[137.016971] Subtest invalid-set-prop: SUCCESS (0.000s)
[137.220177] [082/161] (871s left) kms_addfb_basic (invalid-set-prop-any)
[137.326311] Starting subtest: invalid-set-prop-any
[137.328081] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[137.549256] [083/161] (871s left) kms_addfb_basic (no-handle)
[137.654883] Starting subtest: no-handle
[137.656692] Subtest no-handle: SUCCESS (0.000s)
[137.875236] [084/161] (870s left) kms_addfb_basic (size-max)
[138.028817] Starting subtest: size-max
[138.031316] Subtest size-max: SUCCESS (0.000s)
[138.204236] [085/161] (870s left) kms_addfb_basic (small-bo)
[138.359775] Starting subtest: small-bo
[138.362139] Subtest small-bo: SUCCESS (0.000s)
[138.526026] [086/161] (870s left) kms_addfb_basic (tile-pitch-mismatch)
[138.629311] Starting subtest: tile-pitch-mismatch
[138.631400] Subtest tile-pitch-mismatch: SUCCESS (0.001s)
[138.863597] [087/161] (870s left) kms_addfb_basic (too-high)
[139.018891] Starting subtest: too-high
[139.021162] Subtest too-high: SUCCESS (0.001s)
[139.184957] [088/161] (869s left) kms_addfb_basic (too-wide)
[139.339838] Starting subtest: too-wide
[139.342076] Subtest too-wide: SUCCESS (0.000s)
[139.525112] [089/161] (869s left) kms_addfb_basic (unused-handle)
[139.631742] Starting subtest: unused-handle
[139.633564] Subtest unused-handle: SUCCESS (0.000s)
[139.846437] [090/161] (869s left) kms_addfb_basic (unused-modifier)
[139.949199] Starting subtest: unused-modifier
[139.951373] Subtest unused-modifier: SUCCESS (0.000s)
[140.175337] [091/161] (869s left) kms_addfb_basic (unused-offsets)
[140.277701] Starting subtest: unused-offsets
[140.279917] Subtest unused-offsets: SUCCESS (0.000s)
[140.501073] [092/161] (869s left) kms_addfb_basic (unused-pitches)
[140.602576] Starting subtest: unused-pitches
[140.604841] Subtest unused-pitches: SUCCESS (0.000s)
[140.816153] [093/161] (868s left) kms_busy (basic)
[140.977322] Starting subtest: basic
[140.982076] Starting dynamic subtest: flip
[142.012235] Dynamic subtest flip: SUCCESS (1.028s)
[142.038750] Starting dynamic subtest: modeset
[145.777491] Dynamic subtest modeset: SUCCESS (3.766s)
[145.780910] Subtest basic: SUCCESS (4.798s)
[146.768086] [094/161] (862s left) kms_prop_blob (basic)
[146.874177] Starting subtest: basic
[146.876621] Subtest basic: SUCCESS (0.000s)
[147.014250] [095/161] (862s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[147.174121] Starting subtest: basic-busy-flip-before-cursor-atomic
[147.178893] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[147.317345] [096/161] (862s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[147.476196] Starting subtest: basic-busy-flip-before-cursor-legacy
[147.480967] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[147.615577] [097/161] (862s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[147.771333] Starting subtest: basic-flip-after-cursor-atomic
[149.045753] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.272s)
[150.058428] [098/161] (860s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[150.219122] Starting subtest: basic-flip-after-cursor-legacy
[151.462866] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.242s)
[152.391834] [099/161] (857s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[152.550030] Starting subtest: basic-flip-after-cursor-varying-size
[153.796124] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.247s)
[154.728736] [100/161] (855s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[154.886089] Starting subtest: basic-flip-before-cursor-atomic
[156.134283] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.248s)
[157.065960] [101/161] (853s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[157.222120] Starting subtest: basic-flip-before-cursor-legacy
[158.489413] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.267s)
[159.405570] [102/161] (851s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[159.565562] Starting subtest: basic-flip-before-cursor-varying-size
[160.831591] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.262s)
[161.744660] [103/161] (848s left) kms_dsc (dsc-basic)
[161.901301] Starting subtest: dsc-basic
[161.912866] Subtest dsc-basic: SKIP (0.001s)
[162.063240] [104/161] (848s left) kms_flip (basic-flip-vs-dpms)
[162.219799] Starting subtest: basic-flip-vs-dpms
[162.222274] Starting dynamic subtest: A-eDP1
[165.046841] Dynamic subtest A-eDP1: SUCCESS (2.822s)
[165.080036] Starting dynamic subtest: B-eDP1
[167.409736] Dynamic subtest B-eDP1: SUCCESS (2.358s)
[167.441071] Starting dynamic subtest: C-eDP1
[169.766604] Dynamic subtest C-eDP1: SUCCESS (2.355s)
[169.770142] Subtest basic-flip-vs-dpms: SUCCESS (7.549s)
[170.741798] [105/161] (840s left) kms_flip (basic-flip-vs-modeset)
[170.898836] Starting subtest: basic-flip-vs-modeset
[170.901329] Starting dynamic subtest: A-eDP1
[173.729341] Dynamic subtest A-eDP1: SUCCESS (2.824s)
[173.761633] Starting dynamic subtest: B-eDP1
[176.070697] Dynamic subtest B-eDP1: SUCCESS (2.341s)
[176.098670] Starting dynamic subtest: C-eDP1
[178.432931] Dynamic subtest C-eDP1: SUCCESS (2.359s)
[178.436028] Subtest basic-flip-vs-modeset: SUCCESS (7.537s)
[179.424789] [106/161] (831s left) kms_flip (basic-flip-vs-wf_vblank)
[179.580825] Starting subtest: basic-flip-vs-wf_vblank
[179.586296] Starting dynamic subtest: A-eDP1
[181.890767] Dynamic subtest A-eDP1: SUCCESS (2.306s)
[181.914242] Starting dynamic subtest: B-eDP1
[184.204556] Dynamic subtest B-eDP1: SUCCESS (2.312s)
[184.229362] Starting dynamic subtest: C-eDP1
[186.439041] Dynamic subtest C-eDP1: SUCCESS (2.232s)
[186.446345] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.863s)
[187.822629] [107/161] (823s left) kms_flip (basic-plain-flip)
[187.981755] Starting subtest: basic-plain-flip
[187.987173] Starting dynamic subtest: A-eDP1
[190.010486] Dynamic subtest A-eDP1: SUCCESS (2.020s)
[190.039689] Starting dynamic subtest: B-eDP1
[192.007477] Dynamic subtest B-eDP1: SUCCESS (1.998s)
[192.031603] Starting dynamic subtest: C-eDP1
[194.029565] Dynamic subtest C-eDP1: SUCCESS (2.020s)
[194.036722] Subtest basic-plain-flip: SUCCESS (6.053s)
[195.491305] [108/161] (815s left) kms_force_connector_basic (force-connector-state)
[195.625313] Starting subtest: force-connector-state
[196.481370] Subtest force-connector-state: SUCCESS (0.856s)
[197.493744] [109/161] (813s left) kms_force_connector_basic (force-edid)
[197.625533] Starting subtest: force-edid
[197.906515] Subtest force-edid: SUCCESS (0.279s)
[198.206449] [110/161] (813s left) kms_force_connector_basic (force-load-detect)
[198.335652] Starting subtest: force-load-detect
[198.340224] Subtest force-load-detect: SKIP (0.000s)
[198.559521] [111/161] (812s left) kms_force_connector_basic (prune-stale-modes)
[198.689628] Starting subtest: prune-stale-modes
[199.023616] Subtest prune-stale-modes: SUCCESS (0.333s)
[199.306544] [112/161] (812s left) kms_frontbuffer_tracking (basic)
[199.475448] Starting subtest: basic
[203.548469] Subtest basic: SUCCESS (4.072s)
[203.799750] [113/161] (807s left) kms_hdmi_inject (inject-audio)
[204.240506] Starting subtest: inject-audio
[204.614348] Subtest inject-audio: SUCCESS (0.377s)
[205.268394] [114/161] (806s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[205.430633] Starting subtest: compare-crc-sanitycheck-xr24
[205.433135] Starting dynamic subtest: pipe-A-eDP-1
[206.216615] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.783s)
[206.254364] Starting dynamic subtest: pipe-B-eDP-1
[207.620079] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.392s)
[207.662021] Starting dynamic subtest: pipe-C-eDP-1
[208.984621] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.360s)
[208.987310] Subtest compare-crc-sanitycheck-xr24: SUCCESS (3.554s)
[209.927302] [115/161] (801s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[210.084584] Starting subtest: compare-crc-sanitycheck-nv12
[210.087070] Starting dynamic subtest: pipe-A-eDP-1
[211.180422] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.092s)
[211.208035] Starting dynamic subtest: pipe-B-eDP-1
[212.609161] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.425s)
[212.642408] Starting dynamic subtest: pipe-C-eDP-1
[213.945663] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.326s)
[213.948301] Subtest compare-crc-sanitycheck-nv12: SUCCESS (3.859s)
[214.874338] [116/161] (797s left) kms_pipe_crc_basic (hang-read-crc)
[215.035686] Starting subtest: hang-read-crc
[215.038172] Starting dynamic subtest: pipe-A-eDP-1
[217.527516] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.489s)
[217.574052] Starting dynamic subtest: pipe-B-eDP-1
[220.513929] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.978s)
[220.559406] Starting dynamic subtest: pipe-C-eDP-1
[223.534350] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.011s)
[223.537511] Subtest hang-read-crc: SUCCESS (8.498s)
[224.448284] [117/161] (787s left) kms_pipe_crc_basic (nonblocking-crc)
[224.608729] Starting subtest: nonblocking-crc
[224.611226] Starting dynamic subtest: pipe-A-eDP-1
[225.589343] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.977s)
[225.630538] Starting dynamic subtest: pipe-B-eDP-1
[227.189606] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.592s)
[227.230025] Starting dynamic subtest: pipe-C-eDP-1
[228.774890] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.575s)
[228.778183] Subtest nonblocking-crc: SUCCESS (4.166s)
[229.708379] [118/161] (782s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[229.865510] Starting subtest: nonblocking-crc-frame-sequence
[229.868018] Starting dynamic subtest: pipe-A-eDP-1
[230.860670] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.994s)
[230.907056] Starting dynamic subtest: pipe-B-eDP-1
[232.435411] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.564s)
[232.476636] Starting dynamic subtest: pipe-C-eDP-1
[234.009263] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.567s)
[234.012385] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.146s)
[234.976168] [119/161] (777s left) kms_pipe_crc_basic (read-crc)
[235.136702] Starting subtest: read-crc
[235.139222] Starting dynamic subtest: pipe-A-eDP-1
[236.057151] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.919s)
[236.101508] Starting dynamic subtest: pipe-B-eDP-1
[237.540117] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.473s)
[237.582609] Starting dynamic subtest: pipe-C-eDP-1
[238.995877] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.447s)
[238.999130] Subtest read-crc: SUCCESS (3.862s)
[239.914630] [120/161] (772s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[240.076772] Starting subtest: read-crc-frame-sequence
[240.079227] Starting dynamic subtest: pipe-A-eDP-1
[241.000157] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.922s)
[241.046182] Starting dynamic subtest: pipe-B-eDP-1
[242.482542] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.473s)
[242.523781] Starting dynamic subtest: pipe-C-eDP-1
[243.956900] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.465s)
[243.960340] Subtest read-crc-frame-sequence: SUCCESS (3.883s)
[244.858694] [121/161] (767s left) kms_pm_backlight (basic-brightness)
[245.019836] Starting subtest: basic-brightness
[245.125126] Starting dynamic subtest: eDP-1
[245.729909] Dynamic subtest eDP-1: SUCCESS (0.600s)
[245.732936] Subtest basic-brightness: SUCCESS (0.709s)
[246.649710] [122/161] (765s left) kms_pm_rpm (basic-pci-d3-state)
[248.472453] Starting subtest: basic-pci-d3-state
[249.062039] Subtest basic-pci-d3-state: SUCCESS (0.588s)
[249.295671] [123/161] (763s left) kms_pm_rpm (basic-rte)
[249.398666] Starting subtest: basic-rte
[251.680653] Subtest basic-rte: SUCCESS (2.278s)
[252.984243] [124/161] (759s left) kms_psr (psr-primary-page-flip)
[253.149944] Starting subtest: psr-primary-page-flip
[253.152484] Starting dynamic subtest: eDP-1
[257.074659] Dynamic subtest eDP-1: SUCCESS (3.918s)
[257.076858] Subtest psr-primary-page-flip: SUCCESS (3.922s)
[258.015057] [125/161] (754s left) kms_psr (psr-cursor-plane-move)
[258.172887] Starting subtest: psr-cursor-plane-move
[258.175396] Starting dynamic subtest: eDP-1
[261.993240] Dynamic subtest eDP-1: SUCCESS (3.818s)
[261.996460] Subtest psr-cursor-plane-move: SUCCESS (3.822s)
[262.955358] [126/161] (750s left) kms_psr (psr-sprite-plane-onoff)
[263.115912] Starting subtest: psr-sprite-plane-onoff
[263.118572] Starting dynamic subtest: eDP-1
[267.036449] Dynamic subtest eDP-1: SUCCESS (3.918s)
[267.039599] Subtest psr-sprite-plane-onoff: SUCCESS (3.922s)
[268.005860] [127/161] (745s left) kms_psr (psr-primary-mmap-gtt)
[268.166932] Starting subtest: psr-primary-mmap-gtt
[268.169484] Starting dynamic subtest: eDP-1
[272.115261] Dynamic subtest eDP-1: SUCCESS (3.946s)
[272.117799] Subtest psr-primary-mmap-gtt: SUCCESS (3.950s)
[273.056609] [128/161] (740s left) kms_setmode (basic-clone-single-crtc)
[273.164745] Starting subtest: basic-clone-single-crtc
[273.171533] Subtest basic-clone-single-crtc: SKIP (0.000s)
[273.321579] [129/161] (740s left) i915_pm_rps (basic-api)
[273.435917] Starting subtest: basic-api
[273.441955] Subtest basic-api: SUCCESS (0.005s)
[273.606820] [130/161] (739s left) prime_self_import (basic-llseek-bad)
[273.712578] Starting subtest: basic-llseek-bad
[273.717442] Subtest basic-llseek-bad: SUCCESS (0.003s)
[273.888862] [131/161] (739s left) prime_self_import (basic-llseek-size)
[273.993749] Starting subtest: basic-llseek-size
[273.998520] Subtest basic-llseek-size: SUCCESS (0.005s)
[274.153947] [132/161] (739s left) prime_self_import (basic-with_fd_dup)
[274.257788] Starting subtest: basic-with_fd_dup
[274.262096] Subtest basic-with_fd_dup: SUCCESS (0.005s)
[274.420789] [133/161] (739s left) prime_self_import (basic-with_one_bo)
[274.524892] Starting subtest: basic-with_one_bo
[274.528902] Subtest basic-with_one_bo: SUCCESS (0.005s)
[274.687847] [134/161] (739s left) prime_self_import (basic-with_one_bo_two_files)
[274.791558] Starting subtest: basic-with_one_bo_two_files
[274.796134] Subtest basic-with_one_bo_two_files: SUCCESS (0.004s)
[274.954081] [135/161] (738s left) prime_self_import (basic-with_two_bos)
[275.059533] Starting subtest: basic-with_two_bos
[275.063994] Subtest basic-with_two_bos: SUCCESS (0.005s)
[275.220882] [136/161] (738s left) prime_vgem (basic-fence-flip)
[275.357163] Starting subtest: basic-fence-flip
[275.916477] Subtest basic-fence-flip: SUCCESS (0.562s)
[276.106916] [137/161] (738s left) prime_vgem (basic-fence-mmap)
[276.241105] Starting subtest: basic-fence-mmap
[276.294373] Subtest basic-fence-mmap: SUCCESS (0.053s)
[276.472694] [138/161] (737s left) prime_vgem (basic-fence-read)
[276.595662] Starting subtest: basic-fence-read
[276.698550] Subtest basic-fence-read: SUCCESS (0.103s)
[276.855822] [139/161] (737s left) prime_vgem (basic-gtt)
[276.990546] Starting subtest: basic-gtt
[277.012113] Subtest basic-gtt: SUCCESS (0.024s)
[277.191190] [140/161] (737s left) prime_vgem (basic-read)
[277.320287] Starting subtest: basic-read
[277.367864] Subtest basic-read: SUCCESS (0.047s)
[277.517788] [141/161] (737s left) prime_vgem (basic-write)
[277.645407] Starting subtest: basic-write
[277.712319] Subtest basic-write: SUCCESS (0.066s)
[277.868901] [142/161] (736s left) vgem_basic (setversion)
[277.984953] Starting subtest: setversion
[277.988958] Subtest setversion: SUCCESS (0.000s)
[278.121559] [143/161] (736s left) vgem_basic (create)
[278.235019] Starting subtest: create
[278.237223] Subtest create: SUCCESS (0.001s)
[278.369465] [144/161] (736s left) vgem_basic (debugfs)
[278.484583] Starting subtest: debugfs
[278.486809] Subtest debugfs: SUCCESS (0.001s)
[278.624991] [145/161] (736s left) vgem_basic (dmabuf-export)
[278.735425] Starting subtest: dmabuf-export
[278.739833] Subtest dmabuf-export: SUCCESS (0.003s)
[278.905236] [146/161] (736s left) vgem_basic (dmabuf-fence)
[279.018482] Starting subtest: dmabuf-fence
[279.020662] Subtest dmabuf-fence: SUCCESS (0.001s)
[279.156458] [147/161] (735s left) vgem_basic (dmabuf-fence-before)
[279.272180] Starting subtest: dmabuf-fence-before
[279.274198] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[279.404638] [148/161] (735s left) vgem_basic (dmabuf-mmap)
[279.521818] Starting subtest: dmabuf-mmap
[279.541577] Subtest dmabuf-mmap: SUCCESS (0.024s)
[279.668995] [149/161] (735s left) vgem_basic (mmap)
[279.784970] Starting subtest: mmap
[279.800999] Subtest mmap: SUCCESS (0.017s)
[279.943933] [150/161] (735s left) vgem_basic (second-client)
[280.068935] Starting subtest: second-client
[280.104882] Subtest second-client: SUCCESS (0.034s)
[280.261300] [151/161] (735s left) vgem_basic (sysfs)
[280.369444] Starting subtest: sysfs
[280.371666] Subtest sysfs: SUCCESS (0.001s)
[280.504394] [152/161] (735s left) core_hotunplug (unbind-rebind)
[280.703479] Starting subtest: unbind-rebind
[285.704237] Subtest unbind-rebind: SUCCESS (5.002s)
[285.805811] [153/161] (729s left) vgem_basic (unload)
[285.912351] Starting subtest: unload
[315.102441] Subtest unload: SUCCESS (29.188s)
[315.312296] [154/161] (700s left) i915_module_load (reload)
[315.416794] Starting subtest: reload
[320.308647] Subtest reload: SUCCESS (4.888s)
[320.413987] [155/161] (695s left) gem_lmem_swapping (basic)
[320.563346] Subtest basic: SKIP (0.000s)
[320.675192] [156/161] (695s left) gem_lmem_swapping (parallel-random-engines)
[320.793693] Subtest parallel-random-engines: SKIP (0.000s)
[320.903430] [157/161] (695s left) gem_lmem_swapping (random-engines)
[321.018649] Subtest random-engines: SKIP (0.000s)
[321.150351] [158/161] (695s left) gem_lmem_swapping (verify-random)
[321.266104] Subtest verify-random: SKIP (0.000s)
[321.371202] [159/161] (694s left) i915_pm_rpm (module-reload)
[333.845681] Starting subtest: module-reload
[367.121803] Subtest module-reload: SUCCESS (33.273s)
[367.192321] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[367.195141] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true
[367.200722] [160/161] (649s left) i915_selftest (live)
[367.310501] Starting subtest: live
[367.313197] Starting dynamic subtest: sanitycheck
[370.485450] Dynamic subtest sanitycheck: SUCCESS (3.172s)
[370.512592] Starting dynamic subtest: uncore
[373.734623] Dynamic subtest uncore: SUCCESS (3.244s)
[373.762441] Starting dynamic subtest: workarounds
[377.327441] Dynamic subtest workarounds: SUCCESS (3.587s)
[377.356118] Starting dynamic subtest: gt_engines
[380.977357] Dynamic subtest gt_engines: SUCCESS (3.645s)
[381.004496] Starting dynamic subtest: gt_timelines
[393.213080] Dynamic subtest gt_timelines: SUCCESS (12.230s)
[393.239936] Starting dynamic subtest: gt_contexts
[396.617294] Dynamic subtest gt_contexts: SUCCESS (3.399s)
[396.645258] Starting dynamic subtest: gt_lrc
[402.061504] Dynamic subtest gt_lrc: SUCCESS (5.439s)
[402.088507] Starting dynamic subtest: gt_mocs
[405.347326] Dynamic subtest gt_mocs: SUCCESS (3.281s)
[405.375346] Starting dynamic subtest: gt_pm
[414.583211] Dynamic subtest gt_pm: SUCCESS (9.230s)
[414.610109] Starting dynamic subtest: gt_heartbeat
[417.849307] Dynamic subtest gt_heartbeat: SUCCESS (3.261s)
[417.877183] Starting dynamic subtest: gt_tlb
[422.376372] Dynamic subtest gt_tlb: SUCCESS (4.522s)
[422.404107] Starting dynamic subtest: requests
[431.587056] Dynamic subtest requests: SUCCESS (9.205s)
[431.612974] Starting dynamic subtest: migrate
[437.441345] Dynamic subtest migrate: SUCCESS (5.849s)
[437.468559] Starting dynamic subtest: active
[440.689241] Dynamic subtest active: SUCCESS (3.243s)
[440.713697] Starting dynamic subtest: objects
[445.089119] Dynamic subtest objects: SUCCESS (4.373s)
[445.122671] Starting dynamic subtest: mman
[453.004305] Dynamic subtest mman: SUCCESS (7.934s)
[453.030815] Starting dynamic subtest: dmabuf
[456.347242] Dynamic subtest dmabuf: SUCCESS (3.338s)
[456.374759] Starting dynamic subtest: vma
[459.585306] Dynamic subtest vma: SUCCESS (3.233s)
[459.613320] Starting dynamic subtest: coherency
[466.957601] Dynamic subtest coherency: SUCCESS (7.367s)
[466.985139] Starting dynamic subtest: gtt
[478.120259] Dynamic subtest gtt: SUCCESS (11.157s)
[478.147374] Starting dynamic subtest: gem
[481.556327] Dynamic subtest gem: SUCCESS (3.431s)
[481.583110] Starting dynamic subtest: evict
[486.928256] Dynamic subtest evict: SUCCESS (5.367s)
[486.954518] Starting dynamic subtest: hugepages
[496.275439] Dynamic subtest hugepages: SUCCESS (9.342s)
[496.302540] Starting dynamic subtest: gem_contexts
[513.053489] Dynamic subtest gem_contexts: SUCCESS (16.772s)
[513.074718] Starting dynamic subtest: client
[516.320854] Dynamic subtest client: SUCCESS (3.264s)
[516.345964] Starting dynamic subtest: gem_migrate
[519.531332] Dynamic subtest gem_migrate: SUCCESS (3.206s)
[519.558806] Starting dynamic subtest: reset
[525.667448] Dynamic subtest reset: SUCCESS (6.131s)
[525.694587] Starting dynamic subtest: memory_region
[528.911290] Dynamic subtest memory_region: SUCCESS (3.239s)
[528.938294] Starting dynamic subtest: hangcheck
[555.031775] Dynamic subtest hangcheck: SUCCESS (26.115s)
[555.059458] Starting dynamic subtest: execlists
[567.275619] Dynamic subtest execlists: SUCCESS (12.239s)
[567.302555] Starting dynamic subtest: ring_submission
[570.483022] Dynamic subtest ring_submission: SUCCESS (3.202s)
[570.510920] Starting dynamic subtest: perf
[573.916257] Dynamic subtest perf: SUCCESS (3.428s)
[573.943797] Starting dynamic subtest: slpc
[577.131950] Dynamic subtest slpc: SUCCESS (3.212s)
[577.154806] Starting dynamic subtest: guc
[580.367917] Dynamic subtest guc: SUCCESS (3.230s)
[580.402501] Starting dynamic subtest: guc_multi_lrc
[583.581225] Dynamic subtest guc_multi_lrc: SUCCESS (3.211s)
[583.612557] Starting dynamic subtest: guc_hang
[586.845403] Dynamic subtest guc_hang: SUCCESS (3.263s)
[586.874185] Starting dynamic subtest: late_gt_pm
[590.137483] Dynamic subtest late_gt_pm: SUCCESS (3.287s)
[590.140948] Subtest live: SUCCESS (222.823s)
[590.223197] [161/161] (426s left) dmabuf (all-tests)
[590.335751] Starting subtest: all-tests
[590.338321] Starting dynamic subtest: sanitycheck
[590.432110] Dynamic subtest sanitycheck: SUCCESS (0.095s)
[590.460228] Starting dynamic subtest: dma_fence
[590.700932] Dynamic subtest dma_fence: SUCCESS (0.263s)
[590.726365] Starting dynamic subtest: dma_fence_chain
[604.819316] Dynamic subtest dma_fence_chain: SUCCESS (14.113s)
[604.847494] Starting dynamic subtest: dma_fence_unwrap
[604.942443] Dynamic subtest dma_fence_unwrap: SUCCESS (0.119s)
[604.968741] Starting dynamic subtest: dma_resv
[605.052521] Dynamic subtest dma_resv: SUCCESS (0.105s)
[605.055779] Subtest all-tests: SUCCESS (14.719s)
[605.130847] Closing watchdogs
Done.