[46.561822] Initializing watchdogs
[46.562138]   /dev/watchdog0
[46.604163] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:4e51 Intel Jasperlake (Gen11) 
[46.614098] [001/161] (960s left) i915_module_load (load)
[46.949368] Starting subtest: load
[51.024826] Subtest load: SUCCESS (4.076s)
[51.141494] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[51.145441] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[51.152242] [002/161] (956s left) core_auth (basic-auth)
[51.293099] Starting subtest: basic-auth
[51.296643] Subtest basic-auth: SUCCESS (0.002s)
[51.443673] [003/161] (955s left) debugfs_test (read_all_entries)
[51.571797] Starting subtest: read_all_entries
[51.711621] Subtest read_all_entries: SUCCESS (0.139s)
[51.998481] [004/161] (955s left) debugfs_test (basic-hwmon)
[52.180224] Starting subtest: basic-hwmon
[52.185822] Subtest basic-hwmon: SKIP (0.000s)
[52.400344] [005/161] (955s left) debugfs_test (sysfs)
[52.521251] Starting subtest: sysfs
[52.688936] Subtest sysfs: SUCCESS (0.166s)
[52.910998] [006/161] (954s left) fbdev (eof)
[53.025934] Starting subtest: eof
[53.028816] Subtest eof: SUCCESS (0.001s)
[53.147475] [007/161] (954s left) fbdev (info)
[53.266326] Starting subtest: info
[53.268552] Subtest info: SUCCESS (0.000s)
[53.395029] [008/161] (954s left) fbdev (nullptr)
[53.506847] Starting subtest: nullptr
[53.509405] Subtest nullptr: SUCCESS (0.000s)
[53.627436] [009/161] (954s left) fbdev (read)
[53.740286] Starting subtest: read
[62.283737] Subtest read: SUCCESS (8.542s)
[62.417660] [010/161] (945s left) fbdev (write)
[62.541308] Starting subtest: write
[66.986947] Subtest write: SUCCESS (4.445s)
[67.117186] [011/161] (941s left) gem_basic (bad-close)
[67.228138] Starting subtest: bad-close
[67.233869] Subtest bad-close: SUCCESS (0.000s)
[67.365817] [012/161] (940s left) gem_basic (create-close)
[67.476719] Starting subtest: create-close
[67.481580] Subtest create-close: SUCCESS (0.000s)
[67.632294] [013/161] (940s left) gem_basic (create-fd-close)
[67.746887] Starting subtest: create-fd-close
[67.751597] Subtest create-fd-close: SUCCESS (0.000s)
[67.901436] [014/161] (940s left) gem_busy (busy@all-engines)
[68.039020] Starting subtest: busy
[68.041415] Starting dynamic subtest: all-engines
[68.138473] Dynamic subtest all-engines: SUCCESS (0.100s)
[68.140859] Subtest busy: SUCCESS (0.101s)
[68.620217] [015/161] (939s left) gem_close_race (basic-process)
[68.767713] Starting subtest: basic-process
[68.858388] Subtest basic-process: SUCCESS (0.091s)
[69.125305] [016/161] (939s left) gem_close_race (basic-threads)
[69.271628] Starting subtest: basic-threads
[70.608807] Subtest basic-threads: SUCCESS (1.337s)
[70.898482] [017/161] (937s left) gem_ctx_create (basic)
[71.042579] Starting subtest: basic
[71.045343] Subtest basic: SUCCESS (0.000s)
[71.302288] [018/161] (937s left) gem_ctx_create (basic-files)
[71.438417] Starting subtest: basic-files
[73.476440] Subtest basic-files: SUCCESS (2.037s)
[73.769020] [019/161] (935s left) gem_ctx_exec (basic)
[73.885282] Starting subtest: basic
[73.892955] Subtest basic: SUCCESS (0.008s)
[74.051977] [020/161] (934s left) gem_exec_basic (basic)
[74.180923] Starting subtest: basic
[74.184317] Starting dynamic subtest: rcs0-smem
[74.187449] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[74.209757] Starting dynamic subtest: bcs0-smem
[74.212267] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[74.229577] Starting dynamic subtest: vcs0-smem
[74.231983] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[74.249201] Starting dynamic subtest: vecs0-smem
[74.251595] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[74.253956] Subtest basic: SUCCESS (0.011s)
[74.453609] [021/161] (934s left) gem_exec_create (basic)
[74.589320] Starting subtest: basic
[74.592729] Starting dynamic subtest: smem
[76.921748] Dynamic subtest smem: SUCCESS (2.331s)
[76.924728] Subtest basic: SUCCESS (2.332s)
[77.413707] [022/161] (931s left) gem_exec_fence (basic-busy)
[77.819623] Starting subtest: basic-busy
[77.823232] Starting dynamic subtest: rcs0
[77.870979] Dynamic subtest rcs0: SUCCESS (0.054s)
[77.896378] Starting dynamic subtest: bcs0
[78.167235] Dynamic subtest bcs0: SUCCESS (0.293s)
[78.191813] Starting dynamic subtest: vcs0
[78.455955] Dynamic subtest vcs0: SUCCESS (0.290s)
[78.480691] Starting dynamic subtest: vecs0
[78.655308] Dynamic subtest vecs0: SUCCESS (0.198s)
[78.658902] Subtest basic-busy: SUCCESS (0.840s)
[79.478723] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[79.484551] [023/161] (929s left) gem_exec_fence (basic-wait)
[79.790304] Starting subtest: basic-wait
[79.793511] Starting dynamic subtest: rcs0
[79.816275] Dynamic subtest rcs0: SUCCESS (0.026s)
[79.840845] Starting dynamic subtest: bcs0
[79.848107] Dynamic subtest bcs0: SUCCESS (0.032s)
[79.873558] Starting dynamic subtest: vcs0
[79.879128] Dynamic subtest vcs0: SUCCESS (0.031s)
[79.901138] Starting dynamic subtest: vecs0
[79.910067] Dynamic subtest vecs0: SUCCESS (0.030s)
[79.912747] Subtest basic-wait: SUCCESS (0.120s)
[80.559563] [024/161] (928s left) gem_exec_fence (basic-await)
[80.839866] Starting subtest: basic-await
[80.842868] Starting dynamic subtest: rcs0
[80.998824] Dynamic subtest rcs0: SUCCESS (0.157s)
[81.036108] Starting dynamic subtest: bcs0
[81.161876] Dynamic subtest bcs0: SUCCESS (0.162s)
[81.203097] Starting dynamic subtest: vcs0
[81.360478] Dynamic subtest vcs0: SUCCESS (0.198s)
[81.392315] Starting dynamic subtest: vecs0
[81.533876] Dynamic subtest vecs0: SUCCESS (0.172s)
[81.536653] Subtest basic-await: SUCCESS (0.693s)
[82.225808] [025/161] (927s left) gem_exec_fence (nb-await)
[82.508915] Starting subtest: nb-await
[82.511873] Starting dynamic subtest: rcs0
[82.583777] Dynamic subtest rcs0: SUCCESS (0.073s)
[82.615991] Starting dynamic subtest: bcs0
[82.662733] Dynamic subtest bcs0: SUCCESS (0.076s)
[82.704598] Starting dynamic subtest: vcs0
[82.739789] Dynamic subtest vcs0: SUCCESS (0.077s)
[82.784815] Starting dynamic subtest: vecs0
[82.817402] Dynamic subtest vecs0: SUCCESS (0.077s)
[82.820712] Subtest nb-await: SUCCESS (0.308s)
[83.477947] [026/161] (926s left) gem_exec_gttfill (basic)
[83.615917] Starting subtest: basic
[98.011498] Subtest basic: SUCCESS (14.394s)
[98.297207] [027/161] (911s left) gem_exec_parallel (engines)
[98.519756] Starting subtest: engines
[98.524023] Starting dynamic subtest: basic
[103.595468] Dynamic subtest basic: SUCCESS (5.073s)
[103.629093] Starting dynamic subtest: contexts
[111.150302] Dynamic subtest contexts: SUCCESS (7.557s)
[111.181938] Starting dynamic subtest: fds
[122.847519] Dynamic subtest fds: SUCCESS (11.696s)
[122.895764] Starting dynamic subtest: userptr
[126.358310] Dynamic subtest userptr: SUCCESS (3.491s)
[126.362743] Subtest engines: SUCCESS (27.819s)
[126.660437] [028/161] (883s left) gem_exec_store (basic)
[126.800466] Starting subtest: basic
[126.873419] Subtest basic: SUCCESS (0.073s)
[127.153370] [029/161] (882s left) gem_flink_basic (bad-flink)
[127.265528] Starting subtest: bad-flink
[127.268329] Subtest bad-flink: SUCCESS (0.000s)
[127.413810] [030/161] (882s left) gem_flink_basic (bad-open)
[127.523465] Starting subtest: bad-open
[127.526323] Subtest bad-open: SUCCESS (0.000s)
[127.680458] [031/161] (882s left) gem_flink_basic (basic)
[127.789805] Starting subtest: basic
[127.792488] Subtest basic: SUCCESS (0.000s)
[127.964616] [032/161] (882s left) gem_flink_basic (double-flink)
[128.073317] Starting subtest: double-flink
[128.075883] Subtest double-flink: SUCCESS (0.000s)
[128.246746] [033/161] (882s left) gem_flink_basic (flink-lifetime)
[128.354984] Starting subtest: flink-lifetime
[128.357368] Subtest flink-lifetime: SUCCESS (0.003s)
[128.529578] [034/161] (881s left) gem_huc_copy (huc-copy)
[128.650188] Starting subtest: huc-copy
[128.655545] Subtest huc-copy: SKIP (0.000s)
[128.829604] [035/161] (881s left) gem_linear_blits (basic)
[129.098326] Starting subtest: basic
[129.124396] Subtest basic: SUCCESS (0.027s)
[129.304746] [036/161] (881s left) gem_mmap (basic)
[129.492673] Starting subtest: basic
[129.504439] Subtest basic: SUCCESS (0.001s)
[129.646287] [037/161] (881s left) gem_mmap_gtt (basic)
[129.758497] Starting subtest: basic
[129.761384] Subtest basic: SUCCESS (0.002s)
[129.913206] [038/161] (880s left) gem_render_linear_blits (basic)
[130.034845] Starting subtest: basic
[130.115380] Subtest basic: SUCCESS (0.081s)
[130.246811] [039/161] (880s left) gem_render_tiled_blits (basic)
[130.363607] Starting subtest: basic
[130.461431] Subtest basic: SUCCESS (0.096s)
[130.624357] [040/161] (880s left) gem_ringfill (basic-all)
[130.946479] Starting subtest: basic-all
[132.261495] Subtest basic-all: SUCCESS (1.313s)
[132.417468] [041/161] (878s left) gem_softpin (allocator-basic)
[132.540179] Starting subtest: allocator-basic
[132.736585] Subtest allocator-basic: SUCCESS (0.194s)
[132.956759] [042/161] (878s left) gem_softpin (allocator-basic-reserve)
[133.075339] Starting subtest: allocator-basic-reserve
[133.266860] Subtest allocator-basic-reserve: SUCCESS (0.190s)
[133.451352] [043/161] (877s left) gem_softpin (safe-alignment)
[133.573028] Starting subtest: safe-alignment
[133.603608] Subtest safe-alignment: SUCCESS (0.027s)
[133.785024] [044/161] (877s left) gem_sync (basic-all)
[133.930149] Starting subtest: basic-all
[136.923833] Subtest basic-all: SUCCESS (2.994s)
[137.201678] [045/161] (874s left) gem_sync (basic-each)
[137.342295] Starting subtest: basic-each
[139.809884] Subtest basic-each: SUCCESS (2.467s)
[140.117699] [046/161] (871s left) gem_tiled_blits (basic)
[140.338058] Starting subtest: basic
[140.381171] Subtest basic: SUCCESS (0.043s)
[140.566936] [047/161] (871s left) gem_tiled_fence_blits (basic)
[140.889520] Starting subtest: basic
[140.936541] Subtest basic: SUCCESS (0.052s)
[141.128890] [048/161] (870s left) gem_tiled_pread_basic
[141.801137] [049/161] (870s left) gem_wait (busy@all-engines)
[141.953548] Starting subtest: busy
[141.956511] Starting dynamic subtest: all-engines
[142.480425] Dynamic subtest all-engines: SUCCESS (0.527s)
[142.483279] Subtest busy: SUCCESS (0.528s)
[142.803709] [050/161] (869s left) gem_wait (wait@all-engines)
[142.954522] Starting subtest: wait
[142.957463] Starting dynamic subtest: all-engines
[144.001852] Dynamic subtest all-engines: SUCCESS (1.047s)
[144.005245] Subtest wait: SUCCESS (1.048s)
[144.316179] [051/161] (867s left) i915_getparams_basic (basic-eu-total)
[144.426680] Starting subtest: basic-eu-total
[144.431574] Subtest basic-eu-total: SUCCESS (0.000s)
[144.581086] [052/161] (867s left) i915_getparams_basic (basic-subslice-total)
[144.691414] Starting subtest: basic-subslice-total
[144.696421] Subtest basic-subslice-total: SUCCESS (0.000s)
[144.850912] [053/161] (867s left) i915_hangman (error-state-basic)
[144.990713] Starting subtest: error-state-basic
[145.010919] Subtest error-state-basic: SUCCESS (0.021s)
[145.180838] [054/161] (867s left) i915_pciid
[145.446402] [055/161] (867s left) kms_addfb_basic (addfb25-4-tiled)
[145.624236] Starting subtest: addfb25-4-tiled
[145.626751] Subtest addfb25-4-tiled: SUCCESS (0.001s)
[145.809484] [056/161] (866s left) kms_addfb_basic (addfb25-bad-modifier)
[145.981251] Starting subtest: addfb25-bad-modifier
[145.983708] Subtest addfb25-bad-modifier: SUCCESS (0.001s)
[146.150175] [057/161] (866s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[146.320246] Starting subtest: addfb25-framebuffer-vs-set-tiling
[146.322778] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[146.510478] [058/161] (866s left) kms_addfb_basic (addfb25-modifier-no-flag)
[146.678813] Starting subtest: addfb25-modifier-no-flag
[146.681285] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[146.862408] [059/161] (866s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[147.032556] Starting subtest: addfb25-x-tiled-legacy
[147.035218] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[147.211791] [060/161] (865s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[147.379600] Starting subtest: addfb25-x-tiled-mismatch-legacy
[147.382239] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s)
[147.559579] [061/161] (865s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[147.731389] Starting subtest: addfb25-yf-tiled-legacy
[147.733879] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[147.930235] [062/161] (865s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[148.101292] Starting subtest: addfb25-y-tiled-legacy
[148.103749] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[148.266060] [063/161] (865s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[148.437282] Starting subtest: addfb25-y-tiled-small-legacy
[148.439743] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.001s)
[148.614840] [064/161] (864s left) kms_addfb_basic (bad-pitch-0)
[148.723434] Starting subtest: bad-pitch-0
[148.726023] Subtest bad-pitch-0: SUCCESS (0.000s)
[148.959563] [065/161] (864s left) kms_addfb_basic (bad-pitch-1024)
[149.066641] Starting subtest: bad-pitch-1024
[149.069286] Subtest bad-pitch-1024: SUCCESS (0.000s)
[149.297867] [066/161] (864s left) kms_addfb_basic (bad-pitch-128)
[149.404982] Starting subtest: bad-pitch-128
[149.407461] Subtest bad-pitch-128: SUCCESS (0.000s)
[149.632668] [067/161] (864s left) kms_addfb_basic (bad-pitch-256)
[149.741417] Starting subtest: bad-pitch-256
[149.743812] Subtest bad-pitch-256: SUCCESS (0.000s)
[149.987516] [068/161] (864s left) kms_addfb_basic (bad-pitch-32)
[150.093056] Starting subtest: bad-pitch-32
[150.095545] Subtest bad-pitch-32: SUCCESS (0.000s)
[150.346970] [069/161] (863s left) kms_addfb_basic (bad-pitch-63)
[150.458650] Starting subtest: bad-pitch-63
[150.461141] Subtest bad-pitch-63: SUCCESS (0.000s)
[150.713487] [070/161] (863s left) kms_addfb_basic (bad-pitch-65536)
[150.824391] Starting subtest: bad-pitch-65536
[150.826848] Subtest bad-pitch-65536: SUCCESS (0.001s)
[151.077929] [071/161] (863s left) kms_addfb_basic (bad-pitch-999)
[151.188633] Starting subtest: bad-pitch-999
[151.191282] Subtest bad-pitch-999: SUCCESS (0.000s)
[151.425092] [072/161] (863s left) kms_addfb_basic (basic)
[151.533382] Starting subtest: basic
[151.535878] Subtest basic: SUCCESS (0.000s)
[151.775885] [073/161] (862s left) kms_addfb_basic (basic-x-tiled-legacy)
[151.887559] Starting subtest: basic-x-tiled-legacy
[151.890077] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[152.121155] [074/161] (862s left) kms_addfb_basic (basic-y-tiled-legacy)
[152.230738] Starting subtest: basic-y-tiled-legacy
[152.233161] Subtest basic-y-tiled-legacy: SUCCESS (0.001s)
[152.475229] [075/161] (862s left) kms_addfb_basic (bo-too-small)
[152.643144] Starting subtest: bo-too-small
[152.645711] Subtest bo-too-small: SUCCESS (0.001s)
[152.822791] [076/161] (862s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[152.990590] Starting subtest: bo-too-small-due-to-tiling
[152.993255] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s)
[153.170944] [077/161] (861s left) kms_addfb_basic (clobberred-modifier)
[153.280933] Starting subtest: clobberred-modifier
[153.283385] Subtest clobberred-modifier: SUCCESS (0.000s)
[153.523724] [078/161] (861s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[153.631326] Starting subtest: framebuffer-vs-set-tiling
[153.633771] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[153.860407] [079/161] (861s left) kms_addfb_basic (invalid-get-prop)
[153.971674] Starting subtest: invalid-get-prop
[153.974143] Subtest invalid-get-prop: SUCCESS (0.000s)
[154.215755] [080/161] (861s left) kms_addfb_basic (invalid-get-prop-any)
[154.326649] Starting subtest: invalid-get-prop-any
[154.329142] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[154.565918] [081/161] (860s left) kms_addfb_basic (invalid-set-prop)
[154.672558] Starting subtest: invalid-set-prop
[154.675107] Subtest invalid-set-prop: SUCCESS (0.000s)
[154.901510] [082/161] (860s left) kms_addfb_basic (invalid-set-prop-any)
[155.011958] Starting subtest: invalid-set-prop-any
[155.014482] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[155.235789] [083/161] (860s left) kms_addfb_basic (no-handle)
[155.345729] Starting subtest: no-handle
[155.348477] Subtest no-handle: SUCCESS (0.000s)
[155.595051] [084/161] (860s left) kms_addfb_basic (size-max)
[155.761424] Starting subtest: size-max
[155.763968] Subtest size-max: SUCCESS (0.000s)
[155.936989] [085/161] (859s left) kms_addfb_basic (small-bo)
[156.101378] Starting subtest: small-bo
[156.103972] Subtest small-bo: SUCCESS (0.000s)
[156.336132] [086/161] (859s left) kms_addfb_basic (tile-pitch-mismatch)
[156.457164] Starting subtest: tile-pitch-mismatch
[156.459928] Subtest tile-pitch-mismatch: SUCCESS (0.001s)
[156.711629] [087/161] (859s left) kms_addfb_basic (too-high)
[156.881883] Starting subtest: too-high
[156.884802] Subtest too-high: SUCCESS (0.002s)
[157.067431] [088/161] (859s left) kms_addfb_basic (too-wide)
[157.236833] Starting subtest: too-wide
[157.239747] Subtest too-wide: SUCCESS (0.000s)
[157.403671] [089/161] (858s left) kms_addfb_basic (unused-handle)
[157.514661] Starting subtest: unused-handle
[157.517177] Subtest unused-handle: SUCCESS (0.000s)
[157.764922] [090/161] (858s left) kms_addfb_basic (unused-modifier)
[157.876222] Starting subtest: unused-modifier
[157.878624] Subtest unused-modifier: SUCCESS (0.000s)
[158.115825] [091/161] (858s left) kms_addfb_basic (unused-offsets)
[158.227808] Starting subtest: unused-offsets
[158.230265] Subtest unused-offsets: SUCCESS (0.000s)
[158.470086] [092/161] (858s left) kms_addfb_basic (unused-pitches)
[158.578353] Starting subtest: unused-pitches
[158.580856] Subtest unused-pitches: SUCCESS (0.000s)
[158.835337] [093/161] (857s left) kms_busy (basic)
[159.009376] Starting subtest: basic
[159.014586] Starting dynamic subtest: flip
[160.070674] Dynamic subtest flip: SUCCESS (1.057s)
[160.105595] Starting dynamic subtest: modeset
[164.015364] Dynamic subtest modeset: SUCCESS (3.941s)
[164.018770] Subtest basic: SUCCESS (5.002s)
[165.007620] [094/161] (851s left) kms_prop_blob (basic)
[165.120205] Starting subtest: basic
[165.122888] Subtest basic: SUCCESS (0.000s)
[165.267465] [095/161] (851s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[165.438705] Starting subtest: basic-busy-flip-before-cursor-atomic
[165.444032] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[165.584306] [096/161] (851s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[165.752695] Starting subtest: basic-busy-flip-before-cursor-legacy
[165.757972] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[165.921599] [097/161] (851s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[166.087986] Starting subtest: basic-flip-after-cursor-atomic
[167.358935] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.269s)
[168.287875] [098/161] (848s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[168.457693] Starting subtest: basic-flip-after-cursor-legacy
[169.730706] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.271s)
[170.736940] [099/161] (846s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[170.906642] Starting subtest: basic-flip-after-cursor-varying-size
[172.175875] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.268s)
[173.179985] [100/161] (844s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[173.350781] Starting subtest: basic-flip-before-cursor-atomic
[174.616091] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.266s)
[175.620120] [101/161] (841s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[175.788803] Starting subtest: basic-flip-before-cursor-legacy
[177.062589] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.273s)
[178.080606] [102/161] (839s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[178.249718] Starting subtest: basic-flip-before-cursor-varying-size
[179.519731] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.266s)
[180.528904] [103/161] (837s left) kms_dsc (dsc-basic)
[180.696819] Starting subtest: dsc-basic
[180.709671] Subtest dsc-basic: SKIP (0.001s)
[180.848594] [104/161] (836s left) kms_flip (basic-flip-vs-dpms)
[181.018203] Starting subtest: basic-flip-vs-dpms
[181.024029] Starting dynamic subtest: A-eDP1
[183.986404] Dynamic subtest A-eDP1: SUCCESS (2.959s)
[184.028543] Starting dynamic subtest: B-eDP1
[186.339570] Dynamic subtest B-eDP1: SUCCESS (2.353s)
[186.374757] Starting dynamic subtest: C-eDP1
[188.725195] Dynamic subtest C-eDP1: SUCCESS (2.381s)
[188.728360] Subtest basic-flip-vs-dpms: SUCCESS (7.707s)
[189.686234] [105/161] (828s left) kms_flip (basic-flip-vs-modeset)
[189.854579] Starting subtest: basic-flip-vs-modeset
[189.860498] Starting dynamic subtest: A-eDP1
[192.676681] Dynamic subtest A-eDP1: SUCCESS (2.817s)
[192.719853] Starting dynamic subtest: B-eDP1
[195.050774] Dynamic subtest B-eDP1: SUCCESS (2.369s)
[195.092798] Starting dynamic subtest: C-eDP1
[197.413139] Dynamic subtest C-eDP1: SUCCESS (2.362s)
[197.420627] Subtest basic-flip-vs-modeset: SUCCESS (7.564s)
[198.400942] [106/161] (819s left) kms_flip (basic-flip-vs-wf_vblank)
[198.568568] Starting subtest: basic-flip-vs-wf_vblank
[198.574669] Starting dynamic subtest: A-eDP1
[200.870724] Dynamic subtest A-eDP1: SUCCESS (2.297s)
[200.902722] Starting dynamic subtest: B-eDP1
[203.199445] Dynamic subtest B-eDP1: SUCCESS (2.326s)
[203.233183] Starting dynamic subtest: C-eDP1
[205.551773] Dynamic subtest C-eDP1: SUCCESS (2.350s)
[205.559070] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.988s)
[206.955308] [107/161] (811s left) kms_flip (basic-plain-flip)
[207.126513] Starting subtest: basic-plain-flip
[207.132661] Starting dynamic subtest: A-eDP1
[209.150740] Dynamic subtest A-eDP1: SUCCESS (2.017s)
[209.184213] Starting dynamic subtest: B-eDP1
[211.168034] Dynamic subtest B-eDP1: SUCCESS (2.014s)
[211.198367] Starting dynamic subtest: C-eDP1
[213.205249] Dynamic subtest C-eDP1: SUCCESS (2.035s)
[213.212069] Subtest basic-plain-flip: SUCCESS (6.083s)
[214.568721] [108/161] (803s left) kms_force_connector_basic (force-connector-state)
[214.713763] Starting subtest: force-connector-state
[215.611371] Subtest force-connector-state: SUCCESS (0.896s)
[216.636612] [109/161] (801s left) kms_force_connector_basic (force-edid)
[216.779682] Starting subtest: force-edid
[217.061872] Subtest force-edid: SUCCESS (0.280s)
[217.350794] [110/161] (801s left) kms_force_connector_basic (force-load-detect)
[217.493493] Starting subtest: force-load-detect
[217.499204] Subtest force-load-detect: SKIP (0.000s)
[217.724626] [111/161] (800s left) kms_force_connector_basic (prune-stale-modes)
[217.863310] Starting subtest: prune-stale-modes
[218.205881] Subtest prune-stale-modes: SUCCESS (0.336s)
[218.499404] [112/161] (800s left) kms_frontbuffer_tracking (basic)
[218.683943] Starting subtest: basic
[222.793727] Subtest basic: SUCCESS (4.109s)
[223.027842] [113/161] (795s left) kms_hdmi_inject (inject-audio)
[223.505347] Starting subtest: inject-audio
[223.861702] Subtest inject-audio: SUCCESS (0.360s)
[224.547742] [114/161] (794s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[224.740677] Starting subtest: compare-crc-sanitycheck-xr24
[224.743537] Starting dynamic subtest: pipe-A-eDP-1
[225.572310] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.826s)
[225.616509] Starting dynamic subtest: pipe-B-eDP-1
[226.916299] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.339s)
[226.966851] Starting dynamic subtest: pipe-C-eDP-1
[228.271734] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.346s)
[228.274955] Subtest compare-crc-sanitycheck-xr24: SUCCESS (3.531s)
[229.220617] [115/161] (789s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[229.394723] Starting subtest: compare-crc-sanitycheck-nv12
[229.397579] Starting dynamic subtest: pipe-A-eDP-1
[230.571490] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.172s)
[230.619861] Starting dynamic subtest: pipe-B-eDP-1
[232.010800] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.423s)
[232.075858] Starting dynamic subtest: pipe-C-eDP-1
[233.529741] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.525s)
[233.533287] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.138s)
[234.487797] [116/161] (784s left) kms_pipe_crc_basic (hang-read-crc)
[234.671836] Starting subtest: hang-read-crc
[234.675074] Starting dynamic subtest: pipe-A-eDP-1
[237.235954] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.561s)
[237.285560] Starting dynamic subtest: pipe-B-eDP-1
[240.324842] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.082s)
[240.363570] Starting dynamic subtest: pipe-C-eDP-1
[243.364047] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.029s)
[243.367381] Subtest hang-read-crc: SUCCESS (8.693s)
[244.263343] [117/161] (775s left) kms_pipe_crc_basic (nonblocking-crc)
[244.437582] Starting subtest: nonblocking-crc
[244.440400] Starting dynamic subtest: pipe-A-eDP-1
[245.434521] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.993s)
[245.480839] Starting dynamic subtest: pipe-B-eDP-1
[247.087423] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.643s)
[247.134767] Starting dynamic subtest: pipe-C-eDP-1
[248.687695] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.595s)
[248.691174] Subtest nonblocking-crc: SUCCESS (4.253s)
[249.630657] [118/161] (769s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[249.802508] Starting subtest: nonblocking-crc-frame-sequence
[249.805364] Starting dynamic subtest: pipe-A-eDP-1
[250.798127] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.990s)
[250.849092] Starting dynamic subtest: pipe-B-eDP-1
[252.383462] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.578s)
[252.429571] Starting dynamic subtest: pipe-C-eDP-1
[253.949251] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.560s)
[253.952594] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.150s)
[254.889686] [119/161] (764s left) kms_pipe_crc_basic (read-crc)
[255.059575] Starting subtest: read-crc
[255.062693] Starting dynamic subtest: pipe-A-eDP-1
[255.990616] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.925s)
[256.039766] Starting dynamic subtest: pipe-B-eDP-1
[257.580717] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.583s)
[257.628488] Starting dynamic subtest: pipe-C-eDP-1
[259.160748] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.570s)
[259.164235] Subtest read-crc: SUCCESS (4.101s)
[260.149682] [120/161] (759s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[260.323846] Starting subtest: read-crc-frame-sequence
[260.326619] Starting dynamic subtest: pipe-A-eDP-1
[261.269084] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.939s)
[261.308578] Starting dynamic subtest: pipe-B-eDP-1
[262.837520] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.566s)
[262.886652] Starting dynamic subtest: pipe-C-eDP-1
[264.404124] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.556s)
[264.407509] Subtest read-crc-frame-sequence: SUCCESS (4.082s)
[265.303306] [121/161] (754s left) kms_pm_backlight (basic-brightness)
[265.477819] Starting subtest: basic-brightness
[265.590320] Starting dynamic subtest: eDP-1
[266.161087] Dynamic subtest eDP-1: SUCCESS (0.568s)
[266.166812] Subtest basic-brightness: SUCCESS (0.681s)
[267.094843] [122/161] (752s left) kms_pm_rpm (basic-pci-d3-state)
[268.953532] Starting subtest: basic-pci-d3-state
[269.648413] Subtest basic-pci-d3-state: SUCCESS (0.695s)
[269.877269] [123/161] (750s left) kms_pm_rpm (basic-rte)
[269.991964] Starting subtest: basic-rte
[272.324796] Subtest basic-rte: SUCCESS (2.334s)
[273.651803] [124/161] (746s left) kms_psr (psr-primary-page-flip)
[273.824834] Starting subtest: psr-primary-page-flip
[273.827697] Starting dynamic subtest: eDP-1
[277.839867] Dynamic subtest eDP-1: SUCCESS (4.009s)
[277.842700] Subtest psr-primary-page-flip: SUCCESS (4.014s)
[278.776931] [125/161] (741s left) kms_psr (psr-cursor-plane-move)
[278.952103] Starting subtest: psr-cursor-plane-move
[278.954997] Starting dynamic subtest: eDP-1
[282.882650] Dynamic subtest eDP-1: SUCCESS (3.925s)
[282.885908] Subtest psr-cursor-plane-move: SUCCESS (3.930s)
[283.828474] [126/161] (736s left) kms_psr (psr-sprite-plane-onoff)
[284.001441] Starting subtest: psr-sprite-plane-onoff
[284.004254] Starting dynamic subtest: eDP-1
[288.028492] Dynamic subtest eDP-1: SUCCESS (4.023s)
[288.031725] Subtest psr-sprite-plane-onoff: SUCCESS (4.027s)
[288.984964] [127/161] (731s left) kms_psr (psr-primary-mmap-gtt)
[289.160308] Starting subtest: psr-primary-mmap-gtt
[289.163175] Starting dynamic subtest: eDP-1
[293.085805] Dynamic subtest eDP-1: SUCCESS (3.922s)
[293.089027] Subtest psr-primary-mmap-gtt: SUCCESS (3.927s)
[294.031882] [128/161] (726s left) kms_setmode (basic-clone-single-crtc)
[294.151111] Starting subtest: basic-clone-single-crtc
[294.159468] Subtest basic-clone-single-crtc: SKIP (0.000s)
[294.295272] [129/161] (726s left) i915_pm_rps (basic-api)
[294.420260] Starting subtest: basic-api
[294.427105] Subtest basic-api: SUCCESS (0.007s)
[294.603737] [130/161] (726s left) prime_self_import (basic-llseek-bad)
[294.712432] Starting subtest: basic-llseek-bad
[294.718019] Subtest basic-llseek-bad: SUCCESS (0.005s)
[294.878758] [131/161] (725s left) prime_self_import (basic-llseek-size)
[294.984461] Starting subtest: basic-llseek-size
[294.994259] Subtest basic-llseek-size: SUCCESS (0.008s)
[295.164062] [132/161] (725s left) prime_self_import (basic-with_fd_dup)
[295.270027] Starting subtest: basic-with_fd_dup
[295.279522] Subtest basic-with_fd_dup: SUCCESS (0.008s)
[295.465767] [133/161] (725s left) prime_self_import (basic-with_one_bo)
[295.572070] Starting subtest: basic-with_one_bo
[295.581466] Subtest basic-with_one_bo: SUCCESS (0.009s)
[295.746567] [134/161] (725s left) prime_self_import (basic-with_one_bo_two_files)
[295.854032] Starting subtest: basic-with_one_bo_two_files
[295.864200] Subtest basic-with_one_bo_two_files: SUCCESS (0.007s)
[296.030082] [135/161] (725s left) prime_self_import (basic-with_two_bos)
[296.134586] Starting subtest: basic-with_two_bos
[296.139854] Subtest basic-with_two_bos: SUCCESS (0.008s)
[296.297566] [136/161] (724s left) prime_vgem (basic-fence-flip)
[296.439781] Starting subtest: basic-fence-flip
[297.022886] Subtest basic-fence-flip: SUCCESS (0.582s)
[297.198784] [137/161] (724s left) prime_vgem (basic-fence-mmap)
[297.348162] Starting subtest: basic-fence-mmap
[297.412856] Subtest basic-fence-mmap: SUCCESS (0.062s)
[297.565798] [138/161] (723s left) prime_vgem (basic-fence-read)
[297.712263] Starting subtest: basic-fence-read
[297.818219] Subtest basic-fence-read: SUCCESS (0.109s)
[297.981862] [139/161] (723s left) prime_vgem (basic-gtt)
[298.122756] Starting subtest: basic-gtt
[298.152472] Subtest basic-gtt: SUCCESS (0.029s)
[298.332613] [140/161] (723s left) prime_vgem (basic-read)
[298.480510] Starting subtest: basic-read
[298.531846] Subtest basic-read: SUCCESS (0.051s)
[298.701103] [141/161] (723s left) prime_vgem (basic-write)
[298.840685] Starting subtest: basic-write
[298.907897] Subtest basic-write: SUCCESS (0.067s)
[299.061176] [142/161] (722s left) vgem_basic (setversion)
[299.199682] Starting subtest: setversion
[299.203891] Subtest setversion: SUCCESS (0.000s)
[299.330249] [143/161] (722s left) vgem_basic (create)
[299.444639] Starting subtest: create
[299.447128] Subtest create: SUCCESS (0.001s)
[299.580805] [144/161] (722s left) vgem_basic (debugfs)
[299.708409] Starting subtest: debugfs
[299.710894] Subtest debugfs: SUCCESS (0.001s)
[299.846520] [145/161] (722s left) vgem_basic (dmabuf-export)
[299.979422] Starting subtest: dmabuf-export
[299.984447] Subtest dmabuf-export: SUCCESS (0.005s)
[300.150759] [146/161] (722s left) vgem_basic (dmabuf-fence)
[300.275671] Starting subtest: dmabuf-fence
[300.278395] Subtest dmabuf-fence: SUCCESS (0.001s)
[300.416143] [147/161] (722s left) vgem_basic (dmabuf-fence-before)
[300.545936] Starting subtest: dmabuf-fence-before
[300.548369] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[300.682472] [148/161] (721s left) vgem_basic (dmabuf-mmap)
[300.808934] Starting subtest: dmabuf-mmap
[300.839451] Subtest dmabuf-mmap: SUCCESS (0.032s)
[300.981369] [149/161] (721s left) vgem_basic (mmap)
[301.093963] Starting subtest: mmap
[301.114114] Subtest mmap: SUCCESS (0.023s)
[301.267867] [150/161] (721s left) vgem_basic (second-client)
[301.392582] Starting subtest: second-client
[301.431559] Subtest second-client: SUCCESS (0.033s)
[301.568237] [151/161] (721s left) vgem_basic (sysfs)
[301.691937] Starting subtest: sysfs
[301.694595] Subtest sysfs: SUCCESS (0.001s)
[301.831674] [152/161] (721s left) core_hotunplug (unbind-rebind)
[302.025775] Starting subtest: unbind-rebind
[307.433321] Subtest unbind-rebind: SUCCESS (5.407s)
[307.545940] [153/161] (715s left) vgem_basic (unload)
[307.656283] Starting subtest: unload
[336.853490] Subtest unload: SUCCESS (29.197s)
[337.089968] [154/161] (686s left) i915_module_load (reload)
[337.203548] Starting subtest: reload
[342.616946] Subtest reload: SUCCESS (5.413s)
[342.764686] [155/161] (680s left) gem_lmem_swapping (basic)
[342.907748] Subtest basic: SKIP (0.000s)
[343.045883] [156/161] (680s left) gem_lmem_swapping (parallel-random-engines)
[343.173675] Subtest parallel-random-engines: SKIP (0.000s)
[343.306803] [157/161] (680s left) gem_lmem_swapping (random-engines)
[343.431952] Subtest random-engines: SKIP (0.000s)
[343.556920] [158/161] (680s left) gem_lmem_swapping (verify-random)
[343.682527] Subtest verify-random: SKIP (0.000s)
[343.805321] [159/161] (679s left) i915_pm_rpm (module-reload)
[356.395162] Starting subtest: module-reload
[390.477915] Subtest module-reload: SUCCESS (34.080s)
[390.554571] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[390.557434] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true
[390.563144] [160/161] (633s left) i915_selftest (live)
[390.684600] Starting subtest: live
[390.687829] Starting dynamic subtest: sanitycheck
[394.326472] Dynamic subtest sanitycheck: SUCCESS (3.639s)
[394.371669] Starting dynamic subtest: uncore
[398.000480] Dynamic subtest uncore: SUCCESS (3.669s)
[398.039607] Starting dynamic subtest: workarounds
[401.981467] Dynamic subtest workarounds: SUCCESS (3.976s)
[402.011910] Starting dynamic subtest: gt_engines
[406.039624] Dynamic subtest gt_engines: SUCCESS (4.053s)
[406.080772] Starting dynamic subtest: gt_timelines
[421.870241] Dynamic subtest gt_timelines: SUCCESS (15.826s)
[421.905474] Starting dynamic subtest: gt_contexts
[425.746620] Dynamic subtest gt_contexts: SUCCESS (3.870s)
[425.793963] Starting dynamic subtest: gt_lrc
[431.699874] Dynamic subtest gt_lrc: SUCCESS (5.948s)
[431.733590] Starting dynamic subtest: gt_mocs
[435.530779] Dynamic subtest gt_mocs: SUCCESS (3.825s)
[435.559587] Starting dynamic subtest: gt_pm
[445.636538] Dynamic subtest gt_pm: SUCCESS (10.101s)
[445.678999] Starting dynamic subtest: gt_heartbeat
[449.412683] Dynamic subtest gt_heartbeat: SUCCESS (3.769s)
[449.440491] Starting dynamic subtest: gt_tlb
[454.238530] Dynamic subtest gt_tlb: SUCCESS (4.821s)
[454.268042] Starting dynamic subtest: requests
[463.939235] Dynamic subtest requests: SUCCESS (9.696s)
[463.969900] Starting dynamic subtest: migrate
[470.375559] Dynamic subtest migrate: SUCCESS (6.431s)
[470.404191] Starting dynamic subtest: active
[474.093432] Dynamic subtest active: SUCCESS (3.713s)
[474.126758] Starting dynamic subtest: objects
[478.865947] Dynamic subtest objects: SUCCESS (4.767s)
[478.900534] Starting dynamic subtest: mman
[487.375692] Dynamic subtest mman: SUCCESS (8.505s)
[487.404531] Starting dynamic subtest: dmabuf
[491.119490] Dynamic subtest dmabuf: SUCCESS (3.739s)
[491.148055] Starting dynamic subtest: vma
[494.756211] Dynamic subtest vma: SUCCESS (3.632s)
[494.789815] Starting dynamic subtest: coherency
[500.543638] Dynamic subtest coherency: SUCCESS (5.782s)
[500.577497] Starting dynamic subtest: gtt
[512.440558] Dynamic subtest gtt: SUCCESS (11.891s)
[512.469817] Starting dynamic subtest: gem
[516.501147] Dynamic subtest gem: SUCCESS (4.041s)
[516.539164] Starting dynamic subtest: evict
[522.301230] Dynamic subtest evict: SUCCESS (5.811s)
[522.327979] Starting dynamic subtest: hugepages
[532.260821] Dynamic subtest hugepages: SUCCESS (9.955s)
[532.289247] Starting dynamic subtest: gem_contexts
[550.458367] Dynamic subtest gem_contexts: SUCCESS (18.192s)
[550.484515] Starting dynamic subtest: client
[554.204755] Dynamic subtest client: SUCCESS (3.742s)
[554.236441] Starting dynamic subtest: gem_migrate
[557.876599] Dynamic subtest gem_migrate: SUCCESS (3.666s)
[557.913865] Starting dynamic subtest: reset
[568.385533] Dynamic subtest reset: SUCCESS (10.503s)
[568.415883] Starting dynamic subtest: memory_region
[572.042596] Dynamic subtest memory_region: SUCCESS (3.652s)
[572.073174] Starting dynamic subtest: hangcheck
[598.697829] Dynamic subtest hangcheck: SUCCESS (26.649s)
[598.727713] Starting dynamic subtest: execlists
[611.997664] Dynamic subtest execlists: SUCCESS (13.294s)
[612.025944] Starting dynamic subtest: ring_submission
[615.610643] Dynamic subtest ring_submission: SUCCESS (3.608s)
[615.640503] Starting dynamic subtest: perf
[619.483619] Dynamic subtest perf: SUCCESS (3.868s)
[619.512921] Starting dynamic subtest: slpc
[623.137576] Dynamic subtest slpc: SUCCESS (3.649s)
[623.167929] Starting dynamic subtest: guc
[626.782276] Dynamic subtest guc: SUCCESS (3.640s)
[626.815876] Starting dynamic subtest: guc_multi_lrc
[630.408360] Dynamic subtest guc_multi_lrc: SUCCESS (3.621s)
[630.438383] Starting dynamic subtest: guc_hang
[634.056614] Dynamic subtest guc_hang: SUCCESS (3.643s)
[634.086753] Starting dynamic subtest: late_gt_pm
[637.710563] Dynamic subtest late_gt_pm: SUCCESS (3.649s)
[637.714141] Subtest live: SUCCESS (247.020s)
[637.798225] [161/161] (386s left) dmabuf (all-tests)
[637.913619] Starting subtest: all-tests
[637.916743] Starting dynamic subtest: sanitycheck
[638.010526] Dynamic subtest sanitycheck: SUCCESS (0.095s)
[638.045341] Starting dynamic subtest: dma_fence
[638.246208] Dynamic subtest dma_fence: SUCCESS (0.230s)
[638.278494] Starting dynamic subtest: dma_fence_chain
[653.557418] Dynamic subtest dma_fence_chain: SUCCESS (15.305s)
[653.583620] Starting dynamic subtest: dma_fence_unwrap
[653.670534] Dynamic subtest dma_fence_unwrap: SUCCESS (0.109s)
[653.703765] Starting dynamic subtest: dma_resv
[653.785341] Dynamic subtest dma_resv: SUCCESS (0.110s)
[653.788778] Subtest all-tests: SUCCESS (15.873s)
[653.867494] Closing watchdogs
Done.