[55.422148] Initializing watchdogs
[55.422330]   /dev/watchdog0
[55.463583] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:4e51 Intel Jasperlake (Gen11) 
[55.473666] [001/161] (960s left) i915_module_load (load)
[55.830807] Starting subtest: load
[59.884099] Subtest load: SUCCESS (4.053s)
[60.013308] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.016824] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[60.023471] [002/161] (956s left) core_auth (basic-auth)
[60.166473] Starting subtest: basic-auth
[60.169731] Subtest basic-auth: SUCCESS (0.002s)
[60.307043] [003/161] (955s left) debugfs_test (read_all_entries)
[60.440146] Starting subtest: read_all_entries
[60.584111] Subtest read_all_entries: SUCCESS (0.143s)
[60.865523] [004/161] (955s left) debugfs_test (basic-hwmon)
[61.047820] Starting subtest: basic-hwmon
[61.053730] Subtest basic-hwmon: SKIP (0.000s)
[61.275069] [005/161] (955s left) debugfs_test (sysfs)
[61.393968] Starting subtest: sysfs
[61.560173] Subtest sysfs: SUCCESS (0.165s)
[61.798156] [006/161] (954s left) fbdev (eof)
[61.934854] Starting subtest: eof
[61.937493] Subtest eof: SUCCESS (0.002s)
[62.078134] [007/161] (954s left) fbdev (info)
[62.186582] Starting subtest: info
[62.188906] Subtest info: SUCCESS (0.000s)
[62.315603] [008/161] (954s left) fbdev (nullptr)
[62.426151] Starting subtest: nullptr
[62.428600] Subtest nullptr: SUCCESS (0.000s)
[62.550164] [009/161] (954s left) fbdev (read)
[62.660032] Starting subtest: read
[71.277870] Subtest read: SUCCESS (8.559s)
[71.412254] [010/161] (945s left) fbdev (write)
[71.535539] Starting subtest: write
[76.001581] Subtest write: SUCCESS (4.449s)
[76.337405] [011/161] (940s left) gem_basic (bad-close)
[76.515854] Starting subtest: bad-close
[76.522051] Subtest bad-close: SUCCESS (0.000s)
[76.760527] [012/161] (940s left) gem_basic (create-close)
[76.930044] Starting subtest: create-close
[76.936803] Subtest create-close: SUCCESS (0.000s)
[77.341134] [013/161] (940s left) gem_basic (create-fd-close)
[77.548286] Starting subtest: create-fd-close
[77.557360] Subtest create-fd-close: SUCCESS (0.001s)
[77.908208] [014/161] (939s left) gem_busy (busy@all-engines)
[78.161434] Starting subtest: busy
[78.164356] Starting dynamic subtest: all-engines
[78.304230] Dynamic subtest all-engines: SUCCESS (0.146s)
[78.307972] Subtest busy: SUCCESS (0.147s)
[79.057196] [015/161] (938s left) gem_close_race (basic-process)
[79.210669] Starting subtest: basic-process
[79.307140] Subtest basic-process: SUCCESS (0.099s)
[79.571194] [016/161] (938s left) gem_close_race (basic-threads)
[79.719420] Starting subtest: basic-threads
[81.087858] Subtest basic-threads: SUCCESS (1.369s)
[81.357075] [017/161] (936s left) gem_ctx_create (basic)
[81.492920] Starting subtest: basic
[81.495562] Subtest basic: SUCCESS (0.000s)
[81.756198] [018/161] (936s left) gem_ctx_create (basic-files)
[81.891379] Starting subtest: basic-files
[83.930851] Subtest basic-files: SUCCESS (2.037s)
[84.243893] [019/161] (934s left) gem_ctx_exec (basic)
[84.358859] Starting subtest: basic
[84.367421] Subtest basic: SUCCESS (0.009s)
[84.544351] [020/161] (933s left) gem_exec_basic (basic)
[84.672414] Starting subtest: basic
[84.676455] Starting dynamic subtest: rcs0-smem
[84.679863] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[84.702813] Starting dynamic subtest: bcs0-smem
[84.705029] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[84.723725] Starting dynamic subtest: vcs0-smem
[84.725888] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[84.744370] Starting dynamic subtest: vecs0-smem
[84.746409] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[84.748376] Subtest basic: SUCCESS (0.010s)
[84.946681] [021/161] (933s left) gem_exec_create (basic)
[85.081484] Starting subtest: basic
[85.085227] Starting dynamic subtest: smem
[87.141070] Dynamic subtest smem: SUCCESS (2.055s)
[87.143235] Subtest basic: SUCCESS (2.056s)
[87.433553] [022/161] (931s left) gem_exec_fence (basic-busy)
[87.714258] Starting subtest: basic-busy
[87.717486] Starting dynamic subtest: rcs0
[87.748913] Dynamic subtest rcs0: SUCCESS (0.035s)
[87.776183] Starting dynamic subtest: bcs0
[87.781893] Dynamic subtest bcs0: SUCCESS (0.026s)
[87.805417] Starting dynamic subtest: vcs0
[87.811380] Dynamic subtest vcs0: SUCCESS (0.029s)
[87.833838] Starting dynamic subtest: vecs0
[87.844096] Dynamic subtest vecs0: SUCCESS (0.038s)
[87.846691] Subtest basic-busy: SUCCESS (0.130s)
[88.603051] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[88.608179] [023/161] (930s left) gem_exec_fence (basic-wait)
[88.889868] Starting subtest: basic-wait
[88.893117] Starting dynamic subtest: rcs0
[88.919876] Dynamic subtest rcs0: SUCCESS (0.030s)
[88.946395] Starting dynamic subtest: bcs0
[88.951750] Dynamic subtest bcs0: SUCCESS (0.030s)
[88.974900] Starting dynamic subtest: vcs0
[88.990879] Dynamic subtest vcs0: SUCCESS (0.039s)
[89.018123] Starting dynamic subtest: vecs0
[89.020908] Dynamic subtest vecs0: SUCCESS (0.026s)
[89.023598] Subtest basic-wait: SUCCESS (0.129s)
[89.669202] [024/161] (929s left) gem_exec_fence (basic-await)
[89.950192] Starting subtest: basic-await
[89.953338] Starting dynamic subtest: rcs0
[90.109956] Dynamic subtest rcs0: SUCCESS (0.157s)
[90.149140] Starting dynamic subtest: bcs0
[90.274900] Dynamic subtest bcs0: SUCCESS (0.164s)
[90.314694] Starting dynamic subtest: vcs0
[90.440494] Dynamic subtest vcs0: SUCCESS (0.165s)
[90.483864] Starting dynamic subtest: vecs0
[90.612527] Dynamic subtest vecs0: SUCCESS (0.171s)
[90.615927] Subtest basic-await: SUCCESS (0.661s)
[91.274343] [025/161] (927s left) gem_exec_fence (nb-await)
[91.553544] Starting subtest: nb-await
[91.556768] Starting dynamic subtest: rcs0
[91.633626] Dynamic subtest rcs0: SUCCESS (0.079s)
[91.661849] Starting dynamic subtest: bcs0
[91.707354] Dynamic subtest bcs0: SUCCESS (0.070s)
[91.745375] Starting dynamic subtest: vcs0
[91.784208] Dynamic subtest vcs0: SUCCESS (0.079s)
[91.827363] Starting dynamic subtest: vecs0
[91.860545] Dynamic subtest vecs0: SUCCESS (0.075s)
[91.864053] Subtest nb-await: SUCCESS (0.307s)
[92.507448] [026/161] (926s left) gem_exec_gttfill (basic)
[92.650272] Starting subtest: basic
[107.866133] Subtest basic: SUCCESS (15.213s)
[108.148975] [027/161] (910s left) gem_exec_parallel (engines)
[108.368992] Starting subtest: engines
[108.371962] Starting dynamic subtest: basic
[113.122948] Dynamic subtest basic: SUCCESS (4.754s)
[113.148498] Starting dynamic subtest: contexts
[122.954317] Dynamic subtest contexts: SUCCESS (9.828s)
[122.990102] Starting dynamic subtest: fds
[131.164829] Dynamic subtest fds: SUCCESS (8.211s)
[131.198678] Starting dynamic subtest: userptr
[134.589926] Dynamic subtest userptr: SUCCESS (3.425s)
[134.592542] Subtest engines: SUCCESS (26.220s)
[134.876180] [028/161] (884s left) gem_exec_store (basic)
[135.017570] Starting subtest: basic
[135.079466] Subtest basic: SUCCESS (0.064s)
[135.349074] [029/161] (883s left) gem_flink_basic (bad-flink)
[135.460835] Starting subtest: bad-flink
[135.463731] Subtest bad-flink: SUCCESS (0.000s)
[135.610272] [030/161] (883s left) gem_flink_basic (bad-open)
[135.720074] Starting subtest: bad-open
[135.722916] Subtest bad-open: SUCCESS (0.000s)
[135.879104] [031/161] (883s left) gem_flink_basic (basic)
[135.989696] Starting subtest: basic
[135.992327] Subtest basic: SUCCESS (0.000s)
[136.162506] [032/161] (883s left) gem_flink_basic (double-flink)
[136.270803] Starting subtest: double-flink
[136.273372] Subtest double-flink: SUCCESS (0.000s)
[136.442752] [033/161] (883s left) gem_flink_basic (flink-lifetime)
[136.551569] Starting subtest: flink-lifetime
[136.554251] Subtest flink-lifetime: SUCCESS (0.004s)
[136.730332] [034/161] (883s left) gem_huc_copy (huc-copy)
[136.854757] Starting subtest: huc-copy
[136.859698] Subtest huc-copy: SKIP (0.000s)
[137.045213] [035/161] (882s left) gem_linear_blits (basic)
[137.312270] Starting subtest: basic
[137.334790] Subtest basic: SUCCESS (0.023s)
[137.568912] [036/161] (882s left) gem_mmap (basic)
[137.753074] Starting subtest: basic
[137.764598] Subtest basic: SUCCESS (0.001s)
[137.931262] [037/161] (882s left) gem_mmap_gtt (basic)
[138.042198] Starting subtest: basic
[138.045055] Subtest basic: SUCCESS (0.002s)
[138.192721] [038/161] (882s left) gem_render_linear_blits (basic)
[138.313975] Starting subtest: basic
[138.397700] Subtest basic: SUCCESS (0.083s)
[138.531918] [039/161] (881s left) gem_render_tiled_blits (basic)
[138.652488] Starting subtest: basic
[138.747450] Subtest basic: SUCCESS (0.097s)
[138.903207] [040/161] (881s left) gem_ringfill (basic-all)
[139.244717] Starting subtest: basic-all
[140.536453] Subtest basic-all: SUCCESS (1.290s)
[140.703373] [041/161] (879s left) gem_softpin (allocator-basic)
[140.826027] Starting subtest: allocator-basic
[141.020031] Subtest allocator-basic: SUCCESS (0.189s)
[141.218374] [042/161] (879s left) gem_softpin (allocator-basic-reserve)
[141.341862] Starting subtest: allocator-basic-reserve
[141.538587] Subtest allocator-basic-reserve: SUCCESS (0.198s)
[141.715201] [043/161] (879s left) gem_softpin (safe-alignment)
[141.835242] Starting subtest: safe-alignment
[141.864842] Subtest safe-alignment: SUCCESS (0.029s)
[142.069987] [044/161] (878s left) gem_sync (basic-all)
[142.212178] Starting subtest: basic-all
[144.301292] Subtest basic-all: SUCCESS (2.085s)
[144.584118] [045/161] (876s left) gem_sync (basic-each)
[144.725194] Starting subtest: basic-each
[147.170802] Subtest basic-each: SUCCESS (2.448s)
[147.488479] [046/161] (873s left) gem_tiled_blits (basic)
[147.709289] Starting subtest: basic
[147.756273] Subtest basic: SUCCESS (0.047s)
[147.986463] [047/161] (873s left) gem_tiled_fence_blits (basic)
[148.300909] Starting subtest: basic
[148.349438] Subtest basic: SUCCESS (0.049s)
[148.547695] [048/161] (872s left) gem_tiled_pread_basic
[149.182046] [049/161] (872s left) gem_wait (busy@all-engines)
[149.337354] Starting subtest: busy
[149.340381] Starting dynamic subtest: all-engines
[149.865379] Dynamic subtest all-engines: SUCCESS (0.528s)
[149.868278] Subtest busy: SUCCESS (0.528s)
[150.181421] [050/161] (871s left) gem_wait (wait@all-engines)
[150.327557] Starting subtest: wait
[150.330665] Starting dynamic subtest: all-engines
[151.370184] Dynamic subtest all-engines: SUCCESS (1.042s)
[151.373519] Subtest wait: SUCCESS (1.043s)
[151.695907] [051/161] (869s left) i915_getparams_basic (basic-eu-total)
[151.805448] Starting subtest: basic-eu-total
[151.810926] Subtest basic-eu-total: SUCCESS (0.000s)
[151.965738] [052/161] (869s left) i915_getparams_basic (basic-subslice-total)
[152.076098] Starting subtest: basic-subslice-total
[152.081549] Subtest basic-subslice-total: SUCCESS (0.000s)
[152.228271] [053/161] (869s left) i915_hangman (error-state-basic)
[152.367618] Starting subtest: error-state-basic
[152.386786] Subtest error-state-basic: SUCCESS (0.018s)
[152.548843] [054/161] (869s left) i915_pciid
[152.812409] [055/161] (869s left) kms_addfb_basic (addfb25-4-tiled)
[152.991794] Starting subtest: addfb25-4-tiled
[152.994246] Subtest addfb25-4-tiled: SUCCESS (0.001s)
[153.166709] [056/161] (868s left) kms_addfb_basic (addfb25-bad-modifier)
[153.339447] Starting subtest: addfb25-bad-modifier
[153.341888] Subtest addfb25-bad-modifier: SUCCESS (0.001s)
[153.517783] [057/161] (868s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[153.689310] Starting subtest: addfb25-framebuffer-vs-set-tiling
[153.691824] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[153.874153] [058/161] (868s left) kms_addfb_basic (addfb25-modifier-no-flag)
[154.041848] Starting subtest: addfb25-modifier-no-flag
[154.044425] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[154.227623] [059/161] (868s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[154.397622] Starting subtest: addfb25-x-tiled-legacy
[154.400045] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[154.566794] [060/161] (867s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[154.737604] Starting subtest: addfb25-x-tiled-mismatch-legacy
[154.740318] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s)
[154.932841] [061/161] (867s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[155.108346] Starting subtest: addfb25-yf-tiled-legacy
[155.110727] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[155.287324] [062/161] (867s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[155.457276] Starting subtest: addfb25-y-tiled-legacy
[155.459719] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[155.628708] [063/161] (867s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[155.804663] Starting subtest: addfb25-y-tiled-small-legacy
[155.807161] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.001s)
[155.967780] [064/161] (866s left) kms_addfb_basic (bad-pitch-0)
[156.075389] Starting subtest: bad-pitch-0
[156.077904] Subtest bad-pitch-0: SUCCESS (0.000s)
[156.325868] [065/161] (866s left) kms_addfb_basic (bad-pitch-1024)
[156.434761] Starting subtest: bad-pitch-1024
[156.437264] Subtest bad-pitch-1024: SUCCESS (0.000s)
[156.677154] [066/161] (866s left) kms_addfb_basic (bad-pitch-128)
[156.787442] Starting subtest: bad-pitch-128
[156.789988] Subtest bad-pitch-128: SUCCESS (0.000s)
[157.036686] [067/161] (866s left) kms_addfb_basic (bad-pitch-256)
[157.152249] Starting subtest: bad-pitch-256
[157.154613] Subtest bad-pitch-256: SUCCESS (0.000s)
[157.394497] [068/161] (865s left) kms_addfb_basic (bad-pitch-32)
[157.501312] Starting subtest: bad-pitch-32
[157.503933] Subtest bad-pitch-32: SUCCESS (0.000s)
[157.737943] [069/161] (865s left) kms_addfb_basic (bad-pitch-63)
[157.850317] Starting subtest: bad-pitch-63
[157.852751] Subtest bad-pitch-63: SUCCESS (0.000s)
[158.080999] [070/161] (865s left) kms_addfb_basic (bad-pitch-65536)
[158.192864] Starting subtest: bad-pitch-65536
[158.195304] Subtest bad-pitch-65536: SUCCESS (0.001s)
[158.433352] [071/161] (865s left) kms_addfb_basic (bad-pitch-999)
[158.544639] Starting subtest: bad-pitch-999
[158.547265] Subtest bad-pitch-999: SUCCESS (0.000s)
[158.790408] [072/161] (864s left) kms_addfb_basic (basic)
[158.933207] Starting subtest: basic
[158.935576] Subtest basic: SUCCESS (0.000s)
[159.188698] [073/161] (864s left) kms_addfb_basic (basic-x-tiled-legacy)
[159.300156] Starting subtest: basic-x-tiled-legacy
[159.302816] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[159.548833] [074/161] (864s left) kms_addfb_basic (basic-y-tiled-legacy)
[159.654265] Starting subtest: basic-y-tiled-legacy
[159.656780] Subtest basic-y-tiled-legacy: SUCCESS (0.001s)
[159.884926] [075/161] (864s left) kms_addfb_basic (bo-too-small)
[160.051517] Starting subtest: bo-too-small
[160.054402] Subtest bo-too-small: SUCCESS (0.001s)
[160.230367] [076/161] (863s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[160.398133] Starting subtest: bo-too-small-due-to-tiling
[160.400766] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s)
[160.571551] [077/161] (863s left) kms_addfb_basic (clobberred-modifier)
[160.680592] Starting subtest: clobberred-modifier
[160.683266] Subtest clobberred-modifier: SUCCESS (0.000s)
[160.934081] [078/161] (863s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[161.045871] Starting subtest: framebuffer-vs-set-tiling
[161.048341] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[161.280864] [079/161] (863s left) kms_addfb_basic (invalid-get-prop)
[161.390261] Starting subtest: invalid-get-prop
[161.392740] Subtest invalid-get-prop: SUCCESS (0.000s)
[161.643306] [080/161] (862s left) kms_addfb_basic (invalid-get-prop-any)
[161.751653] Starting subtest: invalid-get-prop-any
[161.754320] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[162.002596] [081/161] (862s left) kms_addfb_basic (invalid-set-prop)
[162.115975] Starting subtest: invalid-set-prop
[162.118526] Subtest invalid-set-prop: SUCCESS (0.000s)
[162.357737] [082/161] (862s left) kms_addfb_basic (invalid-set-prop-any)
[162.465559] Starting subtest: invalid-set-prop-any
[162.468158] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[162.696888] [083/161] (862s left) kms_addfb_basic (no-handle)
[162.807978] Starting subtest: no-handle
[162.810412] Subtest no-handle: SUCCESS (0.000s)
[163.060569] [084/161] (861s left) kms_addfb_basic (size-max)
[163.230422] Starting subtest: size-max
[163.232983] Subtest size-max: SUCCESS (0.000s)
[163.415698] [085/161] (861s left) kms_addfb_basic (small-bo)
[163.581133] Starting subtest: small-bo
[163.583732] Subtest small-bo: SUCCESS (0.000s)
[163.772211] [086/161] (861s left) kms_addfb_basic (tile-pitch-mismatch)
[163.884589] Starting subtest: tile-pitch-mismatch
[163.887016] Subtest tile-pitch-mismatch: SUCCESS (0.001s)
[164.146278] [087/161] (861s left) kms_addfb_basic (too-high)
[164.313616] Starting subtest: too-high
[164.316331] Subtest too-high: SUCCESS (0.002s)
[164.490540] [088/161] (860s left) kms_addfb_basic (too-wide)
[164.658329] Starting subtest: too-wide
[164.660916] Subtest too-wide: SUCCESS (0.000s)
[164.838015] [089/161] (860s left) kms_addfb_basic (unused-handle)
[164.949341] Starting subtest: unused-handle
[164.951836] Subtest unused-handle: SUCCESS (0.000s)
[165.192335] [090/161] (860s left) kms_addfb_basic (unused-modifier)
[165.300204] Starting subtest: unused-modifier
[165.302624] Subtest unused-modifier: SUCCESS (0.000s)
[165.542057] [091/161] (860s left) kms_addfb_basic (unused-offsets)
[165.648685] Starting subtest: unused-offsets
[165.651247] Subtest unused-offsets: SUCCESS (0.000s)
[165.881705] [092/161] (859s left) kms_addfb_basic (unused-pitches)
[165.991280] Starting subtest: unused-pitches
[165.993702] Subtest unused-pitches: SUCCESS (0.000s)
[166.216555] [093/161] (859s left) kms_busy (basic)
[166.391510] Starting subtest: basic
[166.396847] Starting dynamic subtest: flip
[167.449150] Dynamic subtest flip: SUCCESS (1.051s)
[167.479688] Starting dynamic subtest: modeset
[171.445724] Dynamic subtest modeset: SUCCESS (3.998s)
[171.449317] Subtest basic: SUCCESS (5.053s)
[172.432487] [094/161] (853s left) kms_prop_blob (basic)
[172.544546] Starting subtest: basic
[172.547511] Subtest basic: SUCCESS (0.000s)
[172.696910] [095/161] (853s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[172.865359] Starting subtest: basic-busy-flip-before-cursor-atomic
[172.870751] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[173.017403] [096/161] (853s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[173.185124] Starting subtest: basic-busy-flip-before-cursor-legacy
[173.190229] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[173.339340] [097/161] (852s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[173.508067] Starting subtest: basic-flip-after-cursor-atomic
[174.790404] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.280s)
[175.730517] [098/161] (850s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[175.899584] Starting subtest: basic-flip-after-cursor-legacy
[177.172551] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.269s)
[178.183695] [099/161] (848s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[178.353670] Starting subtest: basic-flip-after-cursor-varying-size
[179.621632] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.268s)
[180.640040] [100/161] (845s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[180.811216] Starting subtest: basic-flip-before-cursor-atomic
[182.080700] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.267s)
[183.093429] [101/161] (843s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[183.260512] Starting subtest: basic-flip-before-cursor-legacy
[184.527816] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.267s)
[185.544684] [102/161] (841s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[185.713627] Starting subtest: basic-flip-before-cursor-varying-size
[187.001364] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.285s)
[187.997781] [103/161] (838s left) kms_dsc (dsc-basic)
[188.167821] Starting subtest: dsc-basic
[188.180233] Subtest dsc-basic: SKIP (0.001s)
[188.323182] [104/161] (838s left) kms_flip (basic-flip-vs-dpms)
[188.492511] Starting subtest: basic-flip-vs-dpms
[188.498405] Starting dynamic subtest: A-eDP1
[191.459355] Dynamic subtest A-eDP1: SUCCESS (2.960s)
[191.501627] Starting dynamic subtest: B-eDP1
[193.810349] Dynamic subtest B-eDP1: SUCCESS (2.349s)
[193.852152] Starting dynamic subtest: C-eDP1
[196.220354] Dynamic subtest C-eDP1: SUCCESS (2.404s)
[196.223574] Subtest basic-flip-vs-dpms: SUCCESS (7.729s)
[197.173511] [105/161] (829s left) kms_flip (basic-flip-vs-modeset)
[197.347866] Starting subtest: basic-flip-vs-modeset
[197.353737] Starting dynamic subtest: A-eDP1
[200.191868] Dynamic subtest A-eDP1: SUCCESS (2.837s)
[200.236588] Starting dynamic subtest: B-eDP1
[202.561317] Dynamic subtest B-eDP1: SUCCESS (2.368s)
[202.603653] Starting dynamic subtest: C-eDP1
[204.942257] Dynamic subtest C-eDP1: SUCCESS (2.373s)
[204.945602] Subtest basic-flip-vs-modeset: SUCCESS (7.594s)
[205.912419] [106/161] (821s left) kms_flip (basic-flip-vs-wf_vblank)
[206.083626] Starting subtest: basic-flip-vs-wf_vblank
[206.089735] Starting dynamic subtest: A-eDP1
[208.392986] Dynamic subtest A-eDP1: SUCCESS (2.304s)
[208.425436] Starting dynamic subtest: B-eDP1
[210.726715] Dynamic subtest B-eDP1: SUCCESS (2.331s)
[210.757316] Starting dynamic subtest: C-eDP1
[213.069545] Dynamic subtest C-eDP1: SUCCESS (2.341s)
[213.076262] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.990s)
[214.465750] [107/161] (812s left) kms_flip (basic-plain-flip)
[214.632859] Starting subtest: basic-plain-flip
[214.638646] Starting dynamic subtest: A-eDP1
[216.648740] Dynamic subtest A-eDP1: SUCCESS (2.010s)
[216.680971] Starting dynamic subtest: B-eDP1
[218.668397] Dynamic subtest B-eDP1: SUCCESS (2.018s)
[218.698912] Starting dynamic subtest: C-eDP1
[220.695409] Dynamic subtest C-eDP1: SUCCESS (2.024s)
[220.701958] Subtest basic-plain-flip: SUCCESS (6.067s)
[222.062722] [108/161] (805s left) kms_force_connector_basic (force-connector-state)
[222.205901] Starting subtest: force-connector-state
[223.109773] Subtest force-connector-state: SUCCESS (0.901s)
[224.094359] [109/161] (803s left) kms_force_connector_basic (force-edid)
[224.231898] Starting subtest: force-edid
[224.509676] Subtest force-edid: SUCCESS (0.276s)
[224.812285] [110/161] (802s left) kms_force_connector_basic (force-load-detect)
[224.952684] Starting subtest: force-load-detect
[224.958633] Subtest force-load-detect: SKIP (0.000s)
[225.185879] [111/161] (802s left) kms_force_connector_basic (prune-stale-modes)
[225.325280] Starting subtest: prune-stale-modes
[225.660568] Subtest prune-stale-modes: SUCCESS (0.334s)
[225.944375] [112/161] (801s left) kms_frontbuffer_tracking (basic)
[226.147472] Starting subtest: basic
[230.286673] Subtest basic: SUCCESS (4.139s)
[230.522553] [113/161] (797s left) kms_hdmi_inject (inject-audio)
[230.983043] Starting subtest: inject-audio
[231.342956] Subtest inject-audio: SUCCESS (0.364s)
[232.027206] [114/161] (796s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[232.199450] Starting subtest: compare-crc-sanitycheck-xr24
[232.202315] Starting dynamic subtest: pipe-A-eDP-1
[233.019237] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.815s)
[233.065993] Starting dynamic subtest: pipe-B-eDP-1
[234.448211] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.422s)
[234.499455] Starting dynamic subtest: pipe-C-eDP-1
[235.878731] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.417s)
[235.882029] Subtest compare-crc-sanitycheck-xr24: SUCCESS (3.675s)
[236.821656] [115/161] (791s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[236.996129] Starting subtest: compare-crc-sanitycheck-nv12
[236.998913] Starting dynamic subtest: pipe-A-eDP-1
[238.157733] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.156s)
[238.201311] Starting dynamic subtest: pipe-B-eDP-1
[239.603589] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.439s)
[239.652500] Starting dynamic subtest: pipe-C-eDP-1
[240.970286] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.359s)
[240.973507] Subtest compare-crc-sanitycheck-nv12: SUCCESS (3.975s)
[241.876265] [116/161] (786s left) kms_pipe_crc_basic (hang-read-crc)
[242.046403] Starting subtest: hang-read-crc
[242.049225] Starting dynamic subtest: pipe-A-eDP-1
[244.644697] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.594s)
[244.699347] Starting dynamic subtest: pipe-B-eDP-1
[247.716776] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.066s)
[247.768215] Starting dynamic subtest: pipe-C-eDP-1
[250.864556] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.138s)
[250.867977] Subtest hang-read-crc: SUCCESS (8.819s)
[251.759507] [117/161] (776s left) kms_pipe_crc_basic (nonblocking-crc)
[251.932755] Starting subtest: nonblocking-crc
[251.935705] Starting dynamic subtest: pipe-A-eDP-1
[252.962217] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.025s)
[253.006249] Starting dynamic subtest: pipe-B-eDP-1
[254.516616] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.549s)
[254.562886] Starting dynamic subtest: pipe-C-eDP-1
[256.078577] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.549s)
[256.082062] Subtest nonblocking-crc: SUCCESS (4.146s)
[257.024291] [118/161] (771s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[257.198505] Starting subtest: nonblocking-crc-frame-sequence
[257.201284] Starting dynamic subtest: pipe-A-eDP-1
[258.204944] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.002s)
[258.253957] Starting dynamic subtest: pipe-B-eDP-1
[259.796705] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.585s)
[259.846933] Starting dynamic subtest: pipe-C-eDP-1
[261.342245] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.535s)
[261.345671] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.145s)
[262.285695] [119/161] (766s left) kms_pipe_crc_basic (read-crc)
[262.456535] Starting subtest: read-crc
[262.459338] Starting dynamic subtest: pipe-A-eDP-1
[263.383140] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.921s)
[263.435205] Starting dynamic subtest: pipe-B-eDP-1
[264.975052] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.583s)
[265.022378] Starting dynamic subtest: pipe-C-eDP-1
[266.533939] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.552s)
[266.537426] Subtest read-crc: SUCCESS (4.079s)
[267.439794] [120/161] (761s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[267.614517] Starting subtest: read-crc-frame-sequence
[267.617355] Starting dynamic subtest: pipe-A-eDP-1
[268.567614] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.950s)
[268.620062] Starting dynamic subtest: pipe-B-eDP-1
[270.121814] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.546s)
[270.168615] Starting dynamic subtest: pipe-C-eDP-1
[271.704283] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.572s)
[271.707648] Subtest read-crc-frame-sequence: SUCCESS (4.093s)
[272.699186] [121/161] (756s left) kms_pm_backlight (basic-brightness)
[272.873520] Starting subtest: basic-brightness
[272.980674] Starting dynamic subtest: eDP-1
[273.553379] Dynamic subtest eDP-1: SUCCESS (0.571s)
[273.558172] Subtest basic-brightness: SUCCESS (0.681s)
[274.487359] [122/161] (754s left) kms_pm_rpm (basic-pci-d3-state)
[276.325511] Starting subtest: basic-pci-d3-state
[276.981721] Subtest basic-pci-d3-state: SUCCESS (0.655s)
[277.242640] [123/161] (751s left) kms_pm_rpm (basic-rte)
[277.352456] Starting subtest: basic-rte
[279.738106] Subtest basic-rte: SUCCESS (2.385s)
[281.042385] [124/161] (748s left) kms_psr (psr-primary-page-flip)
[281.218811] Starting subtest: psr-primary-page-flip
[281.221733] Starting dynamic subtest: eDP-1
[285.223220] Dynamic subtest eDP-1: SUCCESS (4.000s)
[285.225945] Subtest psr-primary-page-flip: SUCCESS (4.004s)
[286.164656] [125/161] (743s left) kms_psr (psr-cursor-plane-move)
[286.339065] Starting subtest: psr-cursor-plane-move
[286.341835] Starting dynamic subtest: eDP-1
[290.271541] Dynamic subtest eDP-1: SUCCESS (3.929s)
[290.274772] Subtest psr-cursor-plane-move: SUCCESS (3.935s)
[291.214586] [126/161] (738s left) kms_psr (psr-sprite-plane-onoff)
[291.389321] Starting subtest: psr-sprite-plane-onoff
[291.392206] Starting dynamic subtest: eDP-1
[295.417555] Dynamic subtest eDP-1: SUCCESS (4.026s)
[295.420494] Subtest psr-sprite-plane-onoff: SUCCESS (4.030s)
[296.373910] [127/161] (733s left) kms_psr (psr-primary-mmap-gtt)
[296.547967] Starting subtest: psr-primary-mmap-gtt
[296.550813] Starting dynamic subtest: eDP-1
[300.479075] Dynamic subtest eDP-1: SUCCESS (3.929s)
[300.482474] Subtest psr-primary-mmap-gtt: SUCCESS (3.934s)
[301.418388] [128/161] (728s left) kms_setmode (basic-clone-single-crtc)
[301.536694] Starting subtest: basic-clone-single-crtc
[301.544498] Subtest basic-clone-single-crtc: SKIP (0.000s)
[301.683625] [129/161] (728s left) i915_pm_rps (basic-api)
[301.808927] Starting subtest: basic-api
[301.816050] Subtest basic-api: SUCCESS (0.007s)
[301.987068] [130/161] (727s left) prime_self_import (basic-llseek-bad)
[302.094798] Starting subtest: basic-llseek-bad
[302.100598] Subtest basic-llseek-bad: SUCCESS (0.005s)
[302.271265] [131/161] (727s left) prime_self_import (basic-llseek-size)
[302.376975] Starting subtest: basic-llseek-size
[302.386242] Subtest basic-llseek-size: SUCCESS (0.008s)
[302.552041] [132/161] (727s left) prime_self_import (basic-with_fd_dup)
[302.661761] Starting subtest: basic-with_fd_dup
[302.671384] Subtest basic-with_fd_dup: SUCCESS (0.008s)
[302.853760] [133/161] (727s left) prime_self_import (basic-with_one_bo)
[302.960524] Starting subtest: basic-with_one_bo
[302.969960] Subtest basic-with_one_bo: SUCCESS (0.008s)
[303.134169] [134/161] (727s left) prime_self_import (basic-with_one_bo_two_files)
[303.242974] Starting subtest: basic-with_one_bo_two_files
[303.248044] Subtest basic-with_one_bo_two_files: SUCCESS (0.006s)
[303.403064] [135/161] (726s left) prime_self_import (basic-with_two_bos)
[303.511791] Starting subtest: basic-with_two_bos
[303.516716] Subtest basic-with_two_bos: SUCCESS (0.008s)
[303.686440] [136/161] (726s left) prime_vgem (basic-fence-flip)
[303.812253] Starting subtest: basic-fence-flip
[304.412212] Subtest basic-fence-flip: SUCCESS (0.599s)
[304.603453] [137/161] (725s left) prime_vgem (basic-fence-mmap)
[304.747937] Starting subtest: basic-fence-mmap
[304.814111] Subtest basic-fence-mmap: SUCCESS (0.062s)
[304.987540] [138/161] (725s left) prime_vgem (basic-fence-read)
[305.113260] Starting subtest: basic-fence-read
[305.224314] Subtest basic-fence-read: SUCCESS (0.110s)
[305.390187] [139/161] (725s left) prime_vgem (basic-gtt)
[305.541843] Starting subtest: basic-gtt
[305.571431] Subtest basic-gtt: SUCCESS (0.029s)
[305.753603] [140/161] (725s left) prime_vgem (basic-read)
[305.896358] Starting subtest: basic-read
[305.948797] Subtest basic-read: SUCCESS (0.052s)
[306.103755] [141/161] (724s left) prime_vgem (basic-write)
[306.245922] Starting subtest: basic-write
[306.314369] Subtest basic-write: SUCCESS (0.069s)
[306.467700] [142/161] (724s left) vgem_basic (setversion)
[306.603390] Starting subtest: setversion
[306.607737] Subtest setversion: SUCCESS (0.000s)
[306.735700] [143/161] (724s left) vgem_basic (create)
[306.849804] Starting subtest: create
[306.852507] Subtest create: SUCCESS (0.001s)
[306.987439] [144/161] (724s left) vgem_basic (debugfs)
[307.114836] Starting subtest: debugfs
[307.117362] Subtest debugfs: SUCCESS (0.001s)
[307.255565] [145/161] (724s left) vgem_basic (dmabuf-export)
[307.381122] Starting subtest: dmabuf-export
[307.386418] Subtest dmabuf-export: SUCCESS (0.005s)
[307.566598] [146/161] (723s left) vgem_basic (dmabuf-fence)
[307.685409] Starting subtest: dmabuf-fence
[307.687897] Subtest dmabuf-fence: SUCCESS (0.001s)
[307.820477] [147/161] (723s left) vgem_basic (dmabuf-fence-before)
[307.948413] Starting subtest: dmabuf-fence-before
[307.950971] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[308.088231] [148/161] (723s left) vgem_basic (dmabuf-mmap)
[308.200484] Starting subtest: dmabuf-mmap
[308.230367] Subtest dmabuf-mmap: SUCCESS (0.033s)
[308.370746] [149/161] (723s left) vgem_basic (mmap)
[308.497982] Starting subtest: mmap
[308.518883] Subtest mmap: SUCCESS (0.022s)
[308.653972] [150/161] (723s left) vgem_basic (second-client)
[308.785416] Starting subtest: second-client
[308.817922] Subtest second-client: SUCCESS (0.032s)
[308.967867] [151/161] (723s left) vgem_basic (sysfs)
[309.084953] Starting subtest: sysfs
[309.087585] Subtest sysfs: SUCCESS (0.001s)
[309.228818] [152/161] (722s left) core_hotunplug (unbind-rebind)
[309.449577] Starting subtest: unbind-rebind
[314.828753] Subtest unbind-rebind: SUCCESS (5.379s)
[314.937969] [153/161] (717s left) vgem_basic (unload)
[315.049463] Starting subtest: unload
[344.231261] Subtest unload: SUCCESS (29.178s)
[344.456447] [154/161] (687s left) i915_module_load (reload)
[344.571574] Starting subtest: reload
[349.898175] Subtest reload: SUCCESS (5.326s)
[350.052185] [155/161] (682s left) gem_lmem_swapping (basic)
[350.219709] Subtest basic: SKIP (0.000s)
[350.336064] [156/161] (682s left) gem_lmem_swapping (parallel-random-engines)
[350.463065] Subtest parallel-random-engines: SKIP (0.000s)
[350.586694] [157/161] (682s left) gem_lmem_swapping (random-engines)
[350.710519] Subtest random-engines: SKIP (0.000s)
[350.837215] [158/161] (681s left) gem_lmem_swapping (verify-random)
[350.962586] Subtest verify-random: SKIP (0.000s)
[351.085544] [159/161] (681s left) i915_pm_rpm (module-reload)
[363.679134] Starting subtest: module-reload
[397.832161] Subtest module-reload: SUCCESS (34.151s)
[397.909820] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[397.912567] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true
[397.918252] [160/161] (635s left) i915_selftest (live)
[398.037343] Starting subtest: live
[398.040549] Starting dynamic subtest: sanitycheck
[401.762566] Dynamic subtest sanitycheck: SUCCESS (3.722s)
[401.795562] Starting dynamic subtest: uncore
[405.426390] Dynamic subtest uncore: SUCCESS (3.658s)
[405.459856] Starting dynamic subtest: workarounds
[409.527484] Dynamic subtest workarounds: SUCCESS (4.096s)
[409.567627] Starting dynamic subtest: gt_engines
[413.615416] Dynamic subtest gt_engines: SUCCESS (4.082s)
[413.649229] Starting dynamic subtest: gt_timelines
[430.016161] Dynamic subtest gt_timelines: SUCCESS (16.395s)
[430.049412] Starting dynamic subtest: gt_contexts
[433.839844] Dynamic subtest gt_contexts: SUCCESS (3.818s)
[433.879874] Starting dynamic subtest: gt_lrc
[439.746845] Dynamic subtest gt_lrc: SUCCESS (5.902s)
[439.777219] Starting dynamic subtest: gt_mocs
[443.516539] Dynamic subtest gt_mocs: SUCCESS (3.764s)
[443.550668] Starting dynamic subtest: gt_pm
[453.724612] Dynamic subtest gt_pm: SUCCESS (10.202s)
[453.757728] Starting dynamic subtest: gt_heartbeat
[457.348572] Dynamic subtest gt_heartbeat: SUCCESS (3.619s)
[457.378899] Starting dynamic subtest: gt_tlb
[462.201334] Dynamic subtest gt_tlb: SUCCESS (4.848s)
[462.241361] Starting dynamic subtest: requests
[471.993362] Dynamic subtest requests: SUCCESS (9.788s)
[472.026852] Starting dynamic subtest: migrate
[478.328509] Dynamic subtest migrate: SUCCESS (6.330s)
[478.359464] Starting dynamic subtest: active
[481.952417] Dynamic subtest active: SUCCESS (3.619s)
[481.983510] Starting dynamic subtest: objects
[486.726800] Dynamic subtest objects: SUCCESS (4.770s)
[486.766194] Starting dynamic subtest: mman
[495.223570] Dynamic subtest mman: SUCCESS (8.492s)
[495.251857] Starting dynamic subtest: dmabuf
[498.887532] Dynamic subtest dmabuf: SUCCESS (3.660s)
[498.921386] Starting dynamic subtest: vma
[502.466611] Dynamic subtest vma: SUCCESS (3.573s)
[502.494900] Starting dynamic subtest: coherency
[508.220880] Dynamic subtest coherency: SUCCESS (5.749s)
[508.254370] Starting dynamic subtest: gtt
[519.922542] Dynamic subtest gtt: SUCCESS (11.697s)
[519.956425] Starting dynamic subtest: gem
[524.020437] Dynamic subtest gem: SUCCESS (4.091s)
[524.050037] Starting dynamic subtest: evict
[529.801422] Dynamic subtest evict: SUCCESS (5.776s)
[529.830609] Starting dynamic subtest: hugepages
[539.702076] Dynamic subtest hugepages: SUCCESS (9.895s)
[539.731442] Starting dynamic subtest: gem_contexts
[557.749594] Dynamic subtest gem_contexts: SUCCESS (18.042s)
[557.775726] Starting dynamic subtest: client
[561.412604] Dynamic subtest client: SUCCESS (3.658s)
[561.441780] Starting dynamic subtest: gem_migrate
[565.061601] Dynamic subtest gem_migrate: SUCCESS (3.644s)
[565.091611] Starting dynamic subtest: reset
[575.581497] Dynamic subtest reset: SUCCESS (10.514s)
[575.615932] Starting dynamic subtest: memory_region
[579.155617] Dynamic subtest memory_region: SUCCESS (3.569s)
[579.204283] Starting dynamic subtest: hangcheck
[605.855988] Dynamic subtest hangcheck: SUCCESS (26.695s)
[605.885178] Starting dynamic subtest: execlists
[619.224794] Dynamic subtest execlists: SUCCESS (13.363s)
[619.250910] Starting dynamic subtest: ring_submission
[622.891394] Dynamic subtest ring_submission: SUCCESS (3.655s)
[622.930676] Starting dynamic subtest: perf
[626.913435] Dynamic subtest perf: SUCCESS (4.022s)
[626.942789] Starting dynamic subtest: slpc
[630.503709] Dynamic subtest slpc: SUCCESS (3.585s)
[630.531730] Starting dynamic subtest: guc
[634.098676] Dynamic subtest guc: SUCCESS (3.590s)
[634.128954] Starting dynamic subtest: guc_multi_lrc
[637.692553] Dynamic subtest guc_multi_lrc: SUCCESS (3.589s)
[637.722628] Starting dynamic subtest: guc_hang
[641.441410] Dynamic subtest guc_hang: SUCCESS (3.744s)
[641.471373] Starting dynamic subtest: late_gt_pm
[645.138514] Dynamic subtest late_gt_pm: SUCCESS (3.692s)
[645.142161] Subtest live: SUCCESS (247.094s)
[645.226879] [161/161] (387s left) dmabuf (all-tests)
[645.344500] Starting subtest: all-tests
[645.347533] Starting dynamic subtest: sanitycheck
[645.451973] Dynamic subtest sanitycheck: SUCCESS (0.106s)
[645.485833] Starting dynamic subtest: dma_fence
[645.693402] Dynamic subtest dma_fence: SUCCESS (0.235s)
[645.735382] Starting dynamic subtest: dma_fence_chain
[661.214636] Dynamic subtest dma_fence_chain: SUCCESS (15.515s)
[661.240868] Starting dynamic subtest: dma_fence_unwrap
[661.312339] Dynamic subtest dma_fence_unwrap: SUCCESS (0.094s)
[661.350168] Starting dynamic subtest: dma_resv
[661.413282] Dynamic subtest dma_resv: SUCCESS (0.096s)
[661.416769] Subtest all-tests: SUCCESS (16.071s)
[661.499280] Closing watchdogs
Done.