[118.737659] Initializing watchdogs
[118.737849]   /dev/watchdog0
[118.795477] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:4e51 Intel Jasperlake (Gen11) 
[118.807813] [001/161] (960s left) i915_module_load (load)
[119.138551] Starting subtest: load
[123.889206] Subtest load: SUCCESS (4.749s)
[123.974865] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[123.979249] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[123.986606] [002/161] (955s left) core_auth (basic-auth)
[124.098744] Starting subtest: basic-auth
[124.100256] Subtest basic-auth: SUCCESS (0.002s)
[124.249151] [003/161] (955s left) debugfs_test (read_all_entries)
[124.374711] Starting subtest: read_all_entries
[124.490420] Subtest read_all_entries: SUCCESS (0.115s)
[124.724864] [004/161] (954s left) debugfs_test (basic-hwmon)
[124.875797] Starting subtest: basic-hwmon
[124.878973] Subtest basic-hwmon: SKIP (0.000s)
[125.071744] [005/161] (954s left) debugfs_test (sysfs)
[125.180091] Starting subtest: sysfs
[125.302427] Subtest sysfs: SUCCESS (0.122s)
[125.517596] [006/161] (954s left) fbdev (eof)
[125.638902] Starting subtest: eof
[125.640132] Subtest eof: SUCCESS (0.001s)
[125.782637] [007/161] (954s left) fbdev (info)
[125.880301] Starting subtest: info
[125.881347] Subtest info: SUCCESS (0.000s)
[126.009679] [008/161] (953s left) fbdev (nullptr)
[126.121153] Starting subtest: nullptr
[126.122317] Subtest nullptr: SUCCESS (0.000s)
[126.242079] [009/161] (953s left) fbdev (read)
[126.354084] Starting subtest: read
[133.492606] Subtest read: SUCCESS (7.091s)
[133.574883] [010/161] (946s left) fbdev (write)
[133.689090] Starting subtest: write
[137.508997] Subtest write: SUCCESS (3.773s)
[137.591455] [011/161] (942s left) gem_basic (bad-close)
[137.693509] Starting subtest: bad-close
[137.695998] Subtest bad-close: SUCCESS (0.000s)
[137.827191] [012/161] (942s left) gem_basic (create-close)
[137.929611] Starting subtest: create-close
[137.932258] Subtest create-close: SUCCESS (0.000s)
[138.093945] [013/161] (942s left) gem_basic (create-fd-close)
[138.193735] Starting subtest: create-fd-close
[138.195956] Subtest create-fd-close: SUCCESS (0.000s)
[138.367149] [014/161] (942s left) gem_busy (busy@all-engines)
[138.492195] Starting subtest: busy
[138.493375] Starting dynamic subtest: all-engines
[138.579277] Dynamic subtest all-engines: SUCCESS (0.088s)
[138.580433] Subtest busy: SUCCESS (0.089s)
[139.043717] [015/161] (941s left) gem_close_race (basic-process)
[139.175032] Starting subtest: basic-process
[139.253443] Subtest basic-process: SUCCESS (0.078s)
[139.509701] [016/161] (941s left) gem_close_race (basic-threads)
[139.637514] Starting subtest: basic-threads
[140.914288] Subtest basic-threads: SUCCESS (1.277s)
[141.224556] [017/161] (939s left) gem_ctx_create (basic)
[141.343694] Starting subtest: basic
[141.344858] Subtest basic: SUCCESS (0.000s)
[141.595686] [018/161] (939s left) gem_ctx_create (basic-files)
[141.716877] Starting subtest: basic-files
[143.746499] Subtest basic-files: SUCCESS (2.029s)
[144.050918] [019/161] (936s left) gem_ctx_exec (basic)
[144.156315] Starting subtest: basic
[144.161460] Subtest basic: SUCCESS (0.006s)
[144.328899] [020/161] (936s left) gem_exec_basic (basic)
[144.443389] Starting subtest: basic
[144.444642] Starting dynamic subtest: rcs0-smem
[144.445954] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[144.464666] Starting dynamic subtest: bcs0-smem
[144.465783] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[144.482207] Starting dynamic subtest: vcs0-smem
[144.483281] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[144.499358] Starting dynamic subtest: vecs0-smem
[144.500418] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[144.501461] Subtest basic: SUCCESS (0.007s)
[144.696814] [021/161] (936s left) gem_exec_create (basic)
[144.817746] Starting subtest: basic
[144.818931] Starting dynamic subtest: smem
[146.865864] Dynamic subtest smem: SUCCESS (2.048s)
[146.867057] Subtest basic: SUCCESS (2.048s)
[147.160787] [022/161] (934s left) gem_exec_fence (basic-busy)
[147.421566] Starting subtest: basic-busy
[147.422767] Starting dynamic subtest: rcs0
[147.449320] Dynamic subtest rcs0: SUCCESS (0.028s)
[147.467573] Starting dynamic subtest: bcs0
[147.474411] Dynamic subtest bcs0: SUCCESS (0.025s)
[147.492155] Starting dynamic subtest: vcs0
[147.503580] Dynamic subtest vcs0: SUCCESS (0.029s)
[147.522266] Starting dynamic subtest: vecs0
[147.525969] Dynamic subtest vecs0: SUCCESS (0.021s)
[147.527123] Subtest basic-busy: SUCCESS (0.105s)
[148.216634] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[148.220205] [023/161] (933s left) gem_exec_fence (basic-wait)
[148.494790] Starting subtest: basic-wait
[148.496020] Starting dynamic subtest: rcs0
[148.518486] Dynamic subtest rcs0: SUCCESS (0.024s)
[148.537283] Starting dynamic subtest: bcs0
[148.541308] Dynamic subtest bcs0: SUCCESS (0.023s)
[148.559820] Starting dynamic subtest: vcs0
[148.562344] Dynamic subtest vcs0: SUCCESS (0.021s)
[148.580397] Starting dynamic subtest: vecs0
[148.589446] Dynamic subtest vecs0: SUCCESS (0.026s)
[148.590544] Subtest basic-wait: SUCCESS (0.095s)
[149.204190] [024/161] (932s left) gem_exec_fence (basic-await)
[149.461308] Starting subtest: basic-await
[149.462540] Starting dynamic subtest: rcs0
[149.584872] Dynamic subtest rcs0: SUCCESS (0.123s)
[149.625987] Starting dynamic subtest: bcs0
[149.730494] Dynamic subtest bcs0: SUCCESS (0.142s)
[149.772903] Starting dynamic subtest: vcs0
[149.896805] Dynamic subtest vcs0: SUCCESS (0.157s)
[149.932331] Starting dynamic subtest: vecs0
[150.028331] Dynamic subtest vecs0: SUCCESS (0.139s)
[150.030351] Subtest basic-await: SUCCESS (0.566s)
[150.688957] [025/161] (930s left) gem_exec_fence (nb-await)
[150.960337] Starting subtest: nb-await
[150.961483] Starting dynamic subtest: rcs0
[151.030531] Dynamic subtest rcs0: SUCCESS (0.069s)
[151.053604] Starting dynamic subtest: bcs0
[151.099991] Dynamic subtest bcs0: SUCCESS (0.068s)
[151.139764] Starting dynamic subtest: vcs0
[151.177502] Dynamic subtest vcs0: SUCCESS (0.077s)
[151.218324] Starting dynamic subtest: vecs0
[151.254822] Dynamic subtest vecs0: SUCCESS (0.076s)
[151.256829] Subtest nb-await: SUCCESS (0.294s)
[151.873319] [026/161] (929s left) gem_exec_gttfill (basic)
[151.999227] Starting subtest: basic
[164.863133] Subtest basic: SUCCESS (12.855s)
[165.113113] [027/161] (916s left) gem_exec_parallel (engines)
[165.310938] Starting subtest: engines
[165.312958] Starting dynamic subtest: basic
[168.664178] Dynamic subtest basic: SUCCESS (3.325s)
[168.693130] Starting dynamic subtest: contexts
[173.015674] Dynamic subtest contexts: SUCCESS (4.380s)
[173.038546] Starting dynamic subtest: fds
[184.458292] Dynamic subtest fds: SUCCESS (11.441s)
[184.505683] Starting dynamic subtest: userptr
[187.197876] Dynamic subtest userptr: SUCCESS (2.739s)
[187.198975] Subtest engines: SUCCESS (21.888s)
[187.517913] [028/161] (894s left) gem_exec_store (basic)
[187.640694] Starting subtest: basic
[187.712734] Subtest basic: SUCCESS (0.072s)
[187.978164] [029/161] (893s left) gem_flink_basic (bad-flink)
[188.081463] Starting subtest: bad-flink
[188.082637] Subtest bad-flink: SUCCESS (0.000s)
[188.222973] [030/161] (893s left) gem_flink_basic (bad-open)
[188.321334] Starting subtest: bad-open
[188.322513] Subtest bad-open: SUCCESS (0.000s)
[188.458131] [031/161] (893s left) gem_flink_basic (basic)
[188.554933] Starting subtest: basic
[188.556203] Subtest basic: SUCCESS (0.000s)
[188.706417] [032/161] (893s left) gem_flink_basic (double-flink)
[188.804136] Starting subtest: double-flink
[188.805301] Subtest double-flink: SUCCESS (0.000s)
[188.975921] [033/161] (893s left) gem_flink_basic (flink-lifetime)
[189.074245] Starting subtest: flink-lifetime
[189.076830] Subtest flink-lifetime: SUCCESS (0.002s)
[189.242514] [034/161] (893s left) gem_huc_copy (huc-copy)
[189.350207] Starting subtest: huc-copy
[189.352814] Subtest huc-copy: SKIP (0.000s)
[189.542746] [035/161] (892s left) gem_linear_blits (basic)
[189.788291] Starting subtest: basic
[189.804713] Subtest basic: SUCCESS (0.017s)
[190.024150] [036/161] (892s left) gem_mmap (basic)
[190.193677] Starting subtest: basic
[190.199104] Subtest basic: SUCCESS (0.001s)
[190.358760] [037/161] (892s left) gem_mmap_gtt (basic)
[190.455768] Starting subtest: basic
[190.457354] Subtest basic: SUCCESS (0.001s)
[190.605823] [038/161] (892s left) gem_render_linear_blits (basic)
[190.713801] Starting subtest: basic
[190.776131] Subtest basic: SUCCESS (0.061s)
[190.908980] [039/161] (891s left) gem_render_tiled_blits (basic)
[191.015504] Starting subtest: basic
[191.077841] Subtest basic: SUCCESS (0.063s)
[191.189838] [040/161] (891s left) gem_ringfill (basic-all)
[191.495574] Starting subtest: basic-all
[192.739452] Subtest basic-all: SUCCESS (1.234s)
[192.887322] [041/161] (890s left) gem_softpin (allocator-basic)
[192.998661] Starting subtest: allocator-basic
[193.174411] Subtest allocator-basic: SUCCESS (0.177s)
[193.394527] [042/161] (889s left) gem_softpin (allocator-basic-reserve)
[193.503214] Starting subtest: allocator-basic-reserve
[193.684387] Subtest allocator-basic-reserve: SUCCESS (0.181s)
[193.870948] [043/161] (889s left) gem_softpin (safe-alignment)
[193.981455] Starting subtest: safe-alignment
[194.002778] Subtest safe-alignment: SUCCESS (0.020s)
[194.194909] [044/161] (889s left) gem_sync (basic-all)
[194.319497] Starting subtest: basic-all
[196.787739] Subtest basic-all: SUCCESS (2.468s)
[197.082525] [045/161] (886s left) gem_sync (basic-each)
[197.207475] Starting subtest: basic-each
[199.630700] Subtest basic-each: SUCCESS (2.422s)
[199.897426] [046/161] (883s left) gem_tiled_blits (basic)
[200.097167] Starting subtest: basic
[200.133794] Subtest basic: SUCCESS (0.037s)
[200.369026] [047/161] (883s left) gem_tiled_fence_blits (basic)
[200.659445] Starting subtest: basic
[200.689471] Subtest basic: SUCCESS (0.030s)
[200.875687] [048/161] (882s left) gem_tiled_pread_basic
[201.442823] [049/161] (882s left) gem_wait (busy@all-engines)
[201.580790] Starting subtest: busy
[201.581990] Starting dynamic subtest: all-engines
[202.104135] Dynamic subtest all-engines: SUCCESS (0.524s)
[202.105415] Subtest busy: SUCCESS (0.525s)
[202.409441] [050/161] (881s left) gem_wait (wait@all-engines)
[202.544569] Starting subtest: wait
[202.545759] Starting dynamic subtest: all-engines
[203.589618] Dynamic subtest all-engines: SUCCESS (1.044s)
[203.591596] Subtest wait: SUCCESS (1.045s)
[203.894631] [051/161] (880s left) i915_getparams_basic (basic-eu-total)
[203.995613] Starting subtest: basic-eu-total
[203.997953] Subtest basic-eu-total: SUCCESS (0.000s)
[204.146102] [052/161] (879s left) i915_getparams_basic (basic-subslice-total)
[204.244674] Starting subtest: basic-subslice-total
[204.247128] Subtest basic-subslice-total: SUCCESS (0.000s)
[204.390680] [053/161] (879s left) i915_hangman (error-state-basic)
[204.511457] Starting subtest: error-state-basic
[204.525850] Subtest error-state-basic: SUCCESS (0.014s)
[204.673955] [054/161] (879s left) i915_pciid
[204.930961] [055/161] (879s left) kms_addfb_basic (addfb25-4-tiled)
[205.092149] Starting subtest: addfb25-4-tiled
[205.093287] Subtest addfb25-4-tiled: SUCCESS (0.001s)
[205.266880] [056/161] (879s left) kms_addfb_basic (addfb25-bad-modifier)
[205.421111] Starting subtest: addfb25-bad-modifier
[205.422520] Subtest addfb25-bad-modifier: SUCCESS (0.001s)
[205.603956] [057/161] (878s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[205.755519] Starting subtest: addfb25-framebuffer-vs-set-tiling
[205.758888] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[205.913835] [058/161] (878s left) kms_addfb_basic (addfb25-modifier-no-flag)
[206.069165] Starting subtest: addfb25-modifier-no-flag
[206.070416] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[206.241670] [059/161] (878s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[206.396132] Starting subtest: addfb25-x-tiled-legacy
[206.397427] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[206.572185] [060/161] (878s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[206.725421] Starting subtest: addfb25-x-tiled-mismatch-legacy
[206.726635] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[206.908886] [061/161] (878s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[207.062554] Starting subtest: addfb25-yf-tiled-legacy
[207.063633] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[207.238268] [062/161] (877s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[207.391680] Starting subtest: addfb25-y-tiled-legacy
[207.392827] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[207.560618] [063/161] (877s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[207.714800] Starting subtest: addfb25-y-tiled-small-legacy
[207.715983] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s)
[207.891185] [064/161] (877s left) kms_addfb_basic (bad-pitch-0)
[207.989536] Starting subtest: bad-pitch-0
[207.990765] Subtest bad-pitch-0: SUCCESS (0.000s)
[208.221899] [065/161] (877s left) kms_addfb_basic (bad-pitch-1024)
[208.323594] Starting subtest: bad-pitch-1024
[208.325200] Subtest bad-pitch-1024: SUCCESS (0.000s)
[208.566969] [066/161] (876s left) kms_addfb_basic (bad-pitch-128)
[208.665631] Starting subtest: bad-pitch-128
[208.666752] Subtest bad-pitch-128: SUCCESS (0.000s)
[208.896870] [067/161] (876s left) kms_addfb_basic (bad-pitch-256)
[208.998308] Starting subtest: bad-pitch-256
[208.999462] Subtest bad-pitch-256: SUCCESS (0.000s)
[209.220083] [068/161] (876s left) kms_addfb_basic (bad-pitch-32)
[209.319081] Starting subtest: bad-pitch-32
[209.320253] Subtest bad-pitch-32: SUCCESS (0.000s)
[209.548259] [069/161] (876s left) kms_addfb_basic (bad-pitch-63)
[209.647279] Starting subtest: bad-pitch-63
[209.648388] Subtest bad-pitch-63: SUCCESS (0.000s)
[209.872360] [070/161] (875s left) kms_addfb_basic (bad-pitch-65536)
[209.972927] Starting subtest: bad-pitch-65536
[209.974436] Subtest bad-pitch-65536: SUCCESS (0.000s)
[210.217136] [071/161] (875s left) kms_addfb_basic (bad-pitch-999)
[210.315186] Starting subtest: bad-pitch-999
[210.316349] Subtest bad-pitch-999: SUCCESS (0.000s)
[210.554720] [072/161] (875s left) kms_addfb_basic (basic)
[210.654271] Starting subtest: basic
[210.655349] Subtest basic: SUCCESS (0.000s)
[210.880192] [073/161] (875s left) kms_addfb_basic (basic-x-tiled-legacy)
[210.979497] Starting subtest: basic-x-tiled-legacy
[210.980587] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[211.230462] [074/161] (874s left) kms_addfb_basic (basic-y-tiled-legacy)
[211.330022] Starting subtest: basic-y-tiled-legacy
[211.331171] Subtest basic-y-tiled-legacy: SUCCESS (0.001s)
[211.563183] [075/161] (874s left) kms_addfb_basic (bo-too-small)
[211.716793] Starting subtest: bo-too-small
[211.718268] Subtest bo-too-small: SUCCESS (0.001s)
[211.919023] [076/161] (874s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[212.066845] Starting subtest: bo-too-small-due-to-tiling
[212.068272] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s)
[212.228911] [077/161] (874s left) kms_addfb_basic (clobberred-modifier)
[212.328640] Starting subtest: clobberred-modifier
[212.329877] Subtest clobberred-modifier: SUCCESS (0.000s)
[212.547054] [078/161] (874s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[212.648743] Starting subtest: framebuffer-vs-set-tiling
[212.649835] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[212.875398] [079/161] (873s left) kms_addfb_basic (invalid-get-prop)
[212.976502] Starting subtest: invalid-get-prop
[212.977661] Subtest invalid-get-prop: SUCCESS (0.000s)
[213.201248] [080/161] (873s left) kms_addfb_basic (invalid-get-prop-any)
[213.303469] Starting subtest: invalid-get-prop-any
[213.304982] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[213.534093] [081/161] (873s left) kms_addfb_basic (invalid-set-prop)
[213.636581] Starting subtest: invalid-set-prop
[213.637780] Subtest invalid-set-prop: SUCCESS (0.000s)
[213.873151] [082/161] (873s left) kms_addfb_basic (invalid-set-prop-any)
[213.971095] Starting subtest: invalid-set-prop-any
[213.972167] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[214.198984] [083/161] (872s left) kms_addfb_basic (no-handle)
[214.303257] Starting subtest: no-handle
[214.304350] Subtest no-handle: SUCCESS (0.000s)
[214.539735] [084/161] (872s left) kms_addfb_basic (size-max)
[214.691769] Starting subtest: size-max
[214.693553] Subtest size-max: SUCCESS (0.000s)
[214.874035] [085/161] (872s left) kms_addfb_basic (small-bo)
[215.027919] Starting subtest: small-bo
[215.029141] Subtest small-bo: SUCCESS (0.000s)
[215.198665] [086/161] (872s left) kms_addfb_basic (tile-pitch-mismatch)
[215.302275] Starting subtest: tile-pitch-mismatch
[215.303384] Subtest tile-pitch-mismatch: SUCCESS (0.001s)
[215.520459] [087/161] (871s left) kms_addfb_basic (too-high)
[215.671854] Starting subtest: too-high
[215.674786] Subtest too-high: SUCCESS (0.001s)
[215.868941] [088/161] (871s left) kms_addfb_basic (too-wide)
[216.021113] Starting subtest: too-wide
[216.022376] Subtest too-wide: SUCCESS (0.000s)
[216.186936] [089/161] (871s left) kms_addfb_basic (unused-handle)
[216.285932] Starting subtest: unused-handle
[216.287115] Subtest unused-handle: SUCCESS (0.000s)
[216.555598] [090/161] (871s left) kms_addfb_basic (unused-modifier)
[216.654954] Starting subtest: unused-modifier
[216.656253] Subtest unused-modifier: SUCCESS (0.000s)
[216.893340] [091/161] (871s left) kms_addfb_basic (unused-offsets)
[216.991435] Starting subtest: unused-offsets
[216.992567] Subtest unused-offsets: SUCCESS (0.000s)
[217.233624] [092/161] (870s left) kms_addfb_basic (unused-pitches)
[217.330960] Starting subtest: unused-pitches
[217.332549] Subtest unused-pitches: SUCCESS (0.000s)
[217.584230] [093/161] (870s left) kms_busy (basic)
[217.745550] Starting subtest: basic
[217.748017] Starting dynamic subtest: flip
[218.778598] Dynamic subtest flip: SUCCESS (1.028s)
[218.811243] Starting dynamic subtest: modeset
[222.604440] Dynamic subtest modeset: SUCCESS (3.825s)
[222.606329] Subtest basic: SUCCESS (4.858s)
[223.584176] [094/161] (864s left) kms_prop_blob (basic)
[223.691403] Starting subtest: basic
[223.692515] Subtest basic: SUCCESS (0.000s)
[223.829567] [095/161] (864s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[223.984481] Starting subtest: basic-busy-flip-before-cursor-atomic
[223.986746] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[224.132837] [096/161] (864s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[224.283529] Starting subtest: basic-busy-flip-before-cursor-legacy
[224.285865] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[224.432578] [097/161] (864s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[224.583597] Starting subtest: basic-flip-after-cursor-atomic
[225.842780] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.259s)
[226.767979] [098/161] (861s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[226.921669] Starting subtest: basic-flip-after-cursor-legacy
[228.191818] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.269s)
[229.110551] [099/161] (859s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[229.260572] Starting subtest: basic-flip-after-cursor-varying-size
[230.513343] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.251s)
[231.440147] [100/161] (857s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[231.593478] Starting subtest: basic-flip-before-cursor-atomic
[232.866064] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.270s)
[233.779355] [101/161] (855s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[233.935535] Starting subtest: basic-flip-before-cursor-legacy
[235.191173] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.253s)
[236.154383] [102/161] (852s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[236.309769] Starting subtest: basic-flip-before-cursor-varying-size
[237.578194] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.267s)
[238.570634] [103/161] (850s left) kms_dsc (dsc-basic)
[238.724148] Starting subtest: dsc-basic
[238.729529] Subtest dsc-basic: SKIP (0.001s)
[238.862320] [104/161] (850s left) kms_flip (basic-flip-vs-dpms)
[239.016080] Starting subtest: basic-flip-vs-dpms
[239.017834] Starting dynamic subtest: A-eDP1
[241.877561] Dynamic subtest A-eDP1: SUCCESS (2.858s)
[241.919508] Starting dynamic subtest: B-eDP1
[244.237971] Dynamic subtest B-eDP1: SUCCESS (2.357s)
[244.283834] Starting dynamic subtest: C-eDP1
[246.623203] Dynamic subtest C-eDP1: SUCCESS (2.378s)
[246.625053] Subtest basic-flip-vs-dpms: SUCCESS (7.609s)
[247.579685] [105/161] (841s left) kms_flip (basic-flip-vs-modeset)
[247.733321] Starting subtest: basic-flip-vs-modeset
[247.735231] Starting dynamic subtest: A-eDP1
[250.568514] Dynamic subtest A-eDP1: SUCCESS (2.830s)
[250.614234] Starting dynamic subtest: B-eDP1
[252.923627] Dynamic subtest B-eDP1: SUCCESS (2.349s)
[252.953807] Starting dynamic subtest: C-eDP1
[255.287450] Dynamic subtest C-eDP1: SUCCESS (2.363s)
[255.292695] Subtest basic-flip-vs-modeset: SUCCESS (7.559s)
[256.273311] [106/161] (833s left) kms_flip (basic-flip-vs-wf_vblank)
[256.428342] Starting subtest: basic-flip-vs-wf_vblank
[256.430561] Starting dynamic subtest: A-eDP1
[258.741806] Dynamic subtest A-eDP1: SUCCESS (2.308s)
[258.767079] Starting dynamic subtest: B-eDP1
[260.954079] Dynamic subtest B-eDP1: SUCCESS (2.210s)
[260.979749] Starting dynamic subtest: C-eDP1
[263.291913] Dynamic subtest C-eDP1: SUCCESS (2.335s)
[263.297764] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.869s)
[264.679739] [107/161] (824s left) kms_flip (basic-plain-flip)
[264.834286] Starting subtest: basic-plain-flip
[264.836679] Starting dynamic subtest: A-eDP1
[266.862514] Dynamic subtest A-eDP1: SUCCESS (2.024s)
[266.907181] Starting dynamic subtest: B-eDP1
[268.868691] Dynamic subtest B-eDP1: SUCCESS (1.999s)
[268.910569] Starting dynamic subtest: C-eDP1
[270.886525] Dynamic subtest C-eDP1: SUCCESS (2.016s)
[270.889472] Subtest basic-plain-flip: SUCCESS (6.055s)
[272.241884] [108/161] (817s left) kms_force_connector_basic (force-connector-state)
[272.372207] Starting subtest: force-connector-state
[273.227725] Subtest force-connector-state: SUCCESS (0.857s)
[274.235664] [109/161] (815s left) kms_force_connector_basic (force-edid)
[274.361136] Starting subtest: force-edid
[274.637810] Subtest force-edid: SUCCESS (0.277s)
[274.923834] [110/161] (814s left) kms_force_connector_basic (force-load-detect)
[275.053258] Starting subtest: force-load-detect
[275.055549] Subtest force-load-detect: SKIP (0.000s)
[275.257850] [111/161] (814s left) kms_force_connector_basic (prune-stale-modes)
[275.385278] Starting subtest: prune-stale-modes
[275.719516] Subtest prune-stale-modes: SUCCESS (0.335s)
[276.006172] [112/161] (813s left) kms_frontbuffer_tracking (basic)
[276.168938] Starting subtest: basic
[280.208484] Subtest basic: SUCCESS (4.038s)
[280.453733] [113/161] (809s left) kms_hdmi_inject (inject-audio)
[280.884926] Starting subtest: inject-audio
[281.208314] Subtest inject-audio: SUCCESS (0.323s)
[281.905546] [114/161] (808s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[282.059405] Starting subtest: compare-crc-sanitycheck-xr24
[282.060502] Starting dynamic subtest: pipe-A-eDP-1
[282.832858] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.769s)
[282.873514] Starting dynamic subtest: pipe-B-eDP-1
[284.171255] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.330s)
[284.211065] Starting dynamic subtest: pipe-C-eDP-1
[285.578666] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.400s)
[285.580611] Subtest compare-crc-sanitycheck-xr24: SUCCESS (3.521s)
[286.571911] [115/161] (803s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[286.724192] Starting subtest: compare-crc-sanitycheck-nv12
[286.725448] Starting dynamic subtest: pipe-A-eDP-1
[287.812640] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.083s)
[287.851050] Starting dynamic subtest: pipe-B-eDP-1
[289.224245] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.401s)
[289.274701] Starting dynamic subtest: pipe-C-eDP-1
[290.610261] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.375s)
[290.612235] Subtest compare-crc-sanitycheck-nv12: SUCCESS (3.885s)
[291.532299] [116/161] (798s left) kms_pipe_crc_basic (hang-read-crc)
[291.694357] Starting subtest: hang-read-crc
[291.695459] Starting dynamic subtest: pipe-A-eDP-1
[294.174069] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.477s)
[294.222443] Starting dynamic subtest: pipe-B-eDP-1
[297.247437] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.063s)
[297.297775] Starting dynamic subtest: pipe-C-eDP-1
[300.197495] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.940s)
[300.199608] Subtest hang-read-crc: SUCCESS (8.504s)
[301.098032] [117/161] (789s left) kms_pipe_crc_basic (nonblocking-crc)
[301.253792] Starting subtest: nonblocking-crc
[301.254942] Starting dynamic subtest: pipe-A-eDP-1
[302.268490] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.009s)
[302.312568] Starting dynamic subtest: pipe-B-eDP-1
[303.870328] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.594s)
[303.915213] Starting dynamic subtest: pipe-C-eDP-1
[305.428807] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.550s)
[305.440569] Subtest nonblocking-crc: SUCCESS (4.178s)
[306.373800] [118/161] (784s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[306.526341] Starting subtest: nonblocking-crc-frame-sequence
[306.529826] Starting dynamic subtest: pipe-A-eDP-1
[307.511193] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.981s)
[307.558280] Starting dynamic subtest: pipe-B-eDP-1
[309.129786] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.609s)
[309.178881] Starting dynamic subtest: pipe-C-eDP-1
[310.702091] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.565s)
[310.703898] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.178s)
[311.622073] [119/161] (779s left) kms_pipe_crc_basic (read-crc)
[311.776346] Starting subtest: read-crc
[311.778055] Starting dynamic subtest: pipe-A-eDP-1
[312.704446] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.926s)
[312.754147] Starting dynamic subtest: pipe-B-eDP-1
[314.207223] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.490s)
[314.252036] Starting dynamic subtest: pipe-C-eDP-1
[315.769047] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.552s)
[315.770856] Subtest read-crc: SUCCESS (3.993s)
[316.673081] [120/161] (774s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[316.830479] Starting subtest: read-crc-frame-sequence
[316.834104] Starting dynamic subtest: pipe-A-eDP-1
[317.755638] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.919s)
[317.801183] Starting dynamic subtest: pipe-B-eDP-1
[319.231986] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.470s)
[319.278125] Starting dynamic subtest: pipe-C-eDP-1
[320.691812] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.450s)
[320.699209] Subtest read-crc-frame-sequence: SUCCESS (3.865s)
[321.608727] [121/161] (769s left) kms_pm_backlight (basic-brightness)
[321.764296] Starting subtest: basic-brightness
[321.877750] Starting dynamic subtest: eDP-1
[322.472153] Dynamic subtest eDP-1: SUCCESS (0.593s)
[322.475193] Subtest basic-brightness: SUCCESS (0.706s)
[323.402623] [122/161] (767s left) kms_pm_rpm (basic-pci-d3-state)
[325.227248] Starting subtest: basic-pci-d3-state
[325.832969] Subtest basic-pci-d3-state: SUCCESS (0.604s)
[326.058345] [123/161] (765s left) kms_pm_rpm (basic-rte)
[326.158104] Starting subtest: basic-rte
[328.522899] Subtest basic-rte: SUCCESS (2.364s)
[329.813629] [124/161] (761s left) kms_psr (psr-primary-page-flip)
[329.969961] Starting subtest: psr-primary-page-flip
[329.971115] Starting dynamic subtest: eDP-1
[333.894079] Dynamic subtest eDP-1: SUCCESS (3.920s)
[333.895915] Subtest psr-primary-page-flip: SUCCESS (3.925s)
[334.874424] [125/161] (756s left) kms_psr (psr-cursor-plane-move)
[335.030326] Starting subtest: psr-cursor-plane-move
[335.031432] Starting dynamic subtest: eDP-1
[338.960580] Dynamic subtest eDP-1: SUCCESS (3.920s)
[338.962456] Subtest psr-cursor-plane-move: SUCCESS (3.925s)
[339.912846] [126/161] (751s left) kms_psr (psr-sprite-plane-onoff)
[340.070429] Starting subtest: psr-sprite-plane-onoff
[340.071647] Starting dynamic subtest: eDP-1
[343.995610] Dynamic subtest eDP-1: SUCCESS (3.921s)
[343.997724] Subtest psr-sprite-plane-onoff: SUCCESS (3.925s)
[344.968995] [127/161] (746s left) kms_psr (psr-primary-mmap-gtt)
[345.125365] Starting subtest: psr-primary-mmap-gtt
[345.126457] Starting dynamic subtest: eDP-1
[349.073151] Dynamic subtest eDP-1: SUCCESS (3.944s)
[349.075120] Subtest psr-primary-mmap-gtt: SUCCESS (3.949s)
[350.020135] [128/161] (741s left) kms_setmode (basic-clone-single-crtc)
[350.126478] Starting subtest: basic-clone-single-crtc
[350.129772] Subtest basic-clone-single-crtc: SKIP (0.000s)
[350.263245] [129/161] (741s left) i915_pm_rps (basic-api)
[350.374492] Starting subtest: basic-api
[350.377170] Subtest basic-api: SUCCESS (0.005s)
[350.533367] [130/161] (741s left) prime_self_import (basic-llseek-bad)
[350.632487] Starting subtest: basic-llseek-bad
[350.637423] Subtest basic-llseek-bad: SUCCESS (0.004s)
[350.797109] [131/161] (741s left) prime_self_import (basic-llseek-size)
[350.891782] Starting subtest: basic-llseek-size
[350.897544] Subtest basic-llseek-size: SUCCESS (0.005s)
[351.066868] [132/161] (740s left) prime_self_import (basic-with_fd_dup)
[351.164589] Starting subtest: basic-with_fd_dup
[351.170357] Subtest basic-with_fd_dup: SUCCESS (0.005s)
[351.334609] [133/161] (740s left) prime_self_import (basic-with_one_bo)
[351.432720] Starting subtest: basic-with_one_bo
[351.437786] Subtest basic-with_one_bo: SUCCESS (0.006s)
[351.581428] [134/161] (740s left) prime_self_import (basic-with_one_bo_two_files)
[351.679231] Starting subtest: basic-with_one_bo_two_files
[351.684324] Subtest basic-with_one_bo_two_files: SUCCESS (0.005s)
[351.846742] [135/161] (740s left) prime_self_import (basic-with_two_bos)
[351.943592] Starting subtest: basic-with_two_bos
[351.949128] Subtest basic-with_two_bos: SUCCESS (0.006s)
[352.114662] [136/161] (740s left) prime_vgem (basic-fence-flip)
[352.243319] Starting subtest: basic-fence-flip
[352.814197] Subtest basic-fence-flip: SUCCESS (0.571s)
[353.005573] [137/161] (739s left) prime_vgem (basic-fence-mmap)
[353.136378] Starting subtest: basic-fence-mmap
[353.190715] Subtest basic-fence-mmap: SUCCESS (0.054s)
[353.375634] [138/161] (739s left) prime_vgem (basic-fence-read)
[353.493069] Starting subtest: basic-fence-read
[353.594628] Subtest basic-fence-read: SUCCESS (0.102s)
[353.750235] [139/161] (738s left) prime_vgem (basic-gtt)
[353.886479] Starting subtest: basic-gtt
[353.912774] Subtest basic-gtt: SUCCESS (0.026s)
[354.066788] [140/161] (738s left) prime_vgem (basic-read)
[354.201863] Starting subtest: basic-read
[354.247758] Subtest basic-read: SUCCESS (0.046s)
[354.417119] [141/161] (738s left) prime_vgem (basic-write)
[354.543408] Starting subtest: basic-write
[354.607140] Subtest basic-write: SUCCESS (0.064s)
[354.765989] [142/161] (738s left) vgem_basic (setversion)
[354.884708] Starting subtest: setversion
[354.886768] Subtest setversion: SUCCESS (0.000s)
[355.017940] [143/161] (738s left) vgem_basic (create)
[355.132117] Starting subtest: create
[355.133315] Subtest create: SUCCESS (0.001s)
[355.269049] [144/161] (737s left) vgem_basic (debugfs)
[355.382275] Starting subtest: debugfs
[355.383404] Subtest debugfs: SUCCESS (0.001s)
[355.516362] [145/161] (737s left) vgem_basic (dmabuf-export)
[355.635245] Starting subtest: dmabuf-export
[355.637445] Subtest dmabuf-export: SUCCESS (0.004s)
[355.819609] [146/161] (737s left) vgem_basic (dmabuf-fence)
[355.932288] Starting subtest: dmabuf-fence
[355.933441] Subtest dmabuf-fence: SUCCESS (0.001s)
[356.099911] [147/161] (737s left) vgem_basic (dmabuf-fence-before)
[356.216123] Starting subtest: dmabuf-fence-before
[356.217372] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[356.349183] [148/161] (737s left) vgem_basic (dmabuf-mmap)
[356.467702] Starting subtest: dmabuf-mmap
[356.490327] Subtest dmabuf-mmap: SUCCESS (0.024s)
[356.617093] [149/161] (737s left) vgem_basic (mmap)
[356.732252] Starting subtest: mmap
[356.752054] Subtest mmap: SUCCESS (0.017s)
[356.883401] [150/161] (736s left) vgem_basic (second-client)
[357.001294] Starting subtest: second-client
[357.037349] Subtest second-client: SUCCESS (0.033s)
[357.189661] [151/161] (736s left) vgem_basic (sysfs)
[357.299145] Starting subtest: sysfs
[357.300378] Subtest sysfs: SUCCESS (0.001s)
[357.433675] [152/161] (736s left) core_hotunplug (unbind-rebind)
[357.616830] Starting subtest: unbind-rebind
[362.595758] Subtest unbind-rebind: SUCCESS (4.977s)
[362.692588] [153/161] (731s left) vgem_basic (unload)
[362.792797] Starting subtest: unload
[391.953290] Subtest unload: SUCCESS (29.149s)
[392.151247] [154/161] (702s left) i915_module_load (reload)
[392.257366] Starting subtest: reload
[397.128516] Subtest reload: SUCCESS (4.871s)
[397.231181] [155/161] (697s left) gem_lmem_swapping (basic)
[397.398028] Subtest basic: SKIP (0.000s)
[397.516286] [156/161] (696s left) gem_lmem_swapping (parallel-random-engines)
[397.627798] Subtest parallel-random-engines: SKIP (0.000s)
[397.741339] [157/161] (696s left) gem_lmem_swapping (random-engines)
[397.852901] Subtest random-engines: SKIP (0.000s)
[397.960475] [158/161] (696s left) gem_lmem_swapping (verify-random)
[398.072110] Subtest verify-random: SKIP (0.000s)
[398.175553] [159/161] (696s left) i915_pm_rpm (module-reload)
[410.696461] Starting subtest: module-reload
[444.102192] Subtest module-reload: SUCCESS (33.395s)
[444.164965] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[444.168251] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true
[444.171905] [160/161] (650s left) i915_selftest (live)
[444.281545] Starting subtest: live
[444.282708] Starting dynamic subtest: sanitycheck
[447.540730] Dynamic subtest sanitycheck: SUCCESS (3.249s)
[447.563283] Starting dynamic subtest: uncore
[450.826754] Dynamic subtest uncore: SUCCESS (3.282s)
[450.848887] Starting dynamic subtest: workarounds
[454.393541] Dynamic subtest workarounds: SUCCESS (3.562s)
[454.415220] Starting dynamic subtest: gt_engines
[458.146868] Dynamic subtest gt_engines: SUCCESS (3.748s)
[458.168644] Starting dynamic subtest: gt_timelines
[470.843667] Dynamic subtest gt_timelines: SUCCESS (12.691s)
[470.864950] Starting dynamic subtest: gt_contexts
[474.251317] Dynamic subtest gt_contexts: SUCCESS (3.402s)
[474.272966] Starting dynamic subtest: gt_lrc
[479.771589] Dynamic subtest gt_lrc: SUCCESS (5.515s)
[479.793965] Starting dynamic subtest: gt_mocs
[483.195766] Dynamic subtest gt_mocs: SUCCESS (3.419s)
[483.217497] Starting dynamic subtest: gt_pm
[492.662976] Dynamic subtest gt_pm: FAIL (9.213s)
[492.680263] Starting dynamic subtest: gt_heartbeat
[495.735078] Dynamic subtest gt_heartbeat: SUCCESS (3.319s)
[495.756799] Starting dynamic subtest: gt_tlb
[500.296499] Dynamic subtest gt_tlb: SUCCESS (4.556s)
[500.318200] Starting dynamic subtest: requests
[509.580474] Dynamic subtest requests: SUCCESS (9.278s)
[509.602166] Starting dynamic subtest: migrate
[515.517430] Dynamic subtest migrate: SUCCESS (5.931s)
[515.539796] Starting dynamic subtest: active
[518.791429] Dynamic subtest active: SUCCESS (3.269s)
[518.813375] Starting dynamic subtest: objects
[523.370290] Dynamic subtest objects: SUCCESS (4.575s)
[523.392176] Starting dynamic subtest: mman
[531.211237] Dynamic subtest mman: SUCCESS (7.836s)
[531.232943] Starting dynamic subtest: dmabuf
[534.599965] Dynamic subtest dmabuf: SUCCESS (3.393s)
[534.627040] Starting dynamic subtest: vma
[537.888727] Dynamic subtest vma: SUCCESS (3.274s)
[537.910290] Starting dynamic subtest: coherency
[543.176267] Dynamic subtest coherency: SUCCESS (5.282s)
[543.198330] Starting dynamic subtest: gtt
[554.391063] Dynamic subtest gtt: SUCCESS (11.220s)
[554.416817] Starting dynamic subtest: gem
[558.133871] Dynamic subtest gem: SUCCESS (3.740s)
[558.161306] Starting dynamic subtest: evict
[563.557143] Dynamic subtest evict: SUCCESS (5.418s)
[563.581016] Starting dynamic subtest: hugepages
[573.268807] Dynamic subtest hugepages: SUCCESS (9.704s)
[573.291464] Starting dynamic subtest: gem_contexts
[590.436074] Dynamic subtest gem_contexts: SUCCESS (17.162s)
[590.459654] Starting dynamic subtest: client
[593.757594] Dynamic subtest client: SUCCESS (3.317s)
[593.806204] Starting dynamic subtest: gem_migrate
[597.059949] Dynamic subtest gem_migrate: SUCCESS (3.297s)
[597.082492] Starting dynamic subtest: reset
[604.345855] Dynamic subtest reset: SUCCESS (7.281s)
[604.368900] Starting dynamic subtest: memory_region
[607.597288] Dynamic subtest memory_region: SUCCESS (3.246s)
[607.620081] Starting dynamic subtest: hangcheck
[633.715668] Dynamic subtest hangcheck: SUCCESS (26.123s)
[633.743307] Starting dynamic subtest: execlists
[646.042108] Dynamic subtest execlists: SUCCESS (12.311s)
[646.064428] Starting dynamic subtest: ring_submission
[649.331909] Dynamic subtest ring_submission: SUCCESS (3.284s)
[649.354555] Starting dynamic subtest: perf
[652.889076] Dynamic subtest perf: SUCCESS (3.552s)
[652.911741] Starting dynamic subtest: slpc
[656.148328] Dynamic subtest slpc: SUCCESS (3.254s)
[656.170815] Starting dynamic subtest: guc
[659.389645] Dynamic subtest guc: SUCCESS (3.245s)
[659.418392] Starting dynamic subtest: guc_multi_lrc
[662.663865] Dynamic subtest guc_multi_lrc: SUCCESS (3.260s)
[662.686475] Starting dynamic subtest: guc_hang
[665.956333] Dynamic subtest guc_hang: SUCCESS (3.287s)
[665.978865] Starting dynamic subtest: late_gt_pm
[669.293776] Dynamic subtest late_gt_pm: SUCCESS (3.333s)
[669.295056] Subtest live: FAIL (224.998s)
[669.365192] [161/161] (425s left) dmabuf (all-tests)
[669.470161] Starting subtest: all-tests
[669.471415] Starting dynamic subtest: sanitycheck
[669.577982] Dynamic subtest sanitycheck: SUCCESS (0.106s)
[669.606100] Starting dynamic subtest: dma_fence
[669.829482] Dynamic subtest dma_fence: SUCCESS (0.247s)
[669.866229] Starting dynamic subtest: dma_fence_chain
[684.251051] Dynamic subtest dma_fence_chain: SUCCESS (14.406s)
[684.272227] Starting dynamic subtest: dma_fence_unwrap
[684.350941] Dynamic subtest dma_fence_unwrap: SUCCESS (0.105s)
[684.376966] Starting dynamic subtest: dma_resv
[684.455942] Dynamic subtest dma_resv: SUCCESS (0.100s)
[684.458528] Subtest all-tests: SUCCESS (14.987s)
[684.533242] Closing watchdogs
Done.