[43.426514] Initializing watchdogs
[43.426562]   /dev/watchdog0
[43.440303] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:46a6 Intel Alderlake_p (Gen12) Alder Lake-P GT2 [Iris Xe Graphics]
[43.443277] [001/162] (960s left) i915_module_load (load)
[43.473697] Starting subtest: load
[48.014314] Subtest load: SUCCESS (4.617s)
[48.035441] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[48.036636] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[48.038894] [002/162] (955s left) core_auth (basic-auth)
[48.116845] Starting subtest: basic-auth
[48.117687] Subtest basic-auth: SUCCESS (0.002s)
[48.192282] [003/162] (955s left) core_debugfs (read-all-entries)
[48.218885] Starting subtest: read-all-entries
[48.288954] Subtest read-all-entries: SUCCESS (0.072s)
[48.388786] [004/162] (955s left) core_sysfs (read-all-entries)
[48.414100] Starting subtest: read-all-entries
[48.416588] Subtest read-all-entries: SUCCESS (0.003s)
[48.506232] [005/162] (955s left) fbdev (eof)
[48.545205] Starting subtest: eof
[48.545904] Subtest eof: SUCCESS (0.000s)
[48.644818] [006/162] (955s left) fbdev (info)
[48.668486] Starting subtest: info
[48.669230] Subtest info: SUCCESS (0.000s)
[48.742673] [007/162] (955s left) fbdev (nullptr)
[48.786644] Starting subtest: nullptr
[48.787392] Subtest nullptr: SUCCESS (0.000s)
[48.851322] [008/162] (955s left) fbdev (read)
[48.883042] Starting subtest: read
[51.234661] Subtest read: SUCCESS (2.387s)
[51.270625] [009/162] (952s left) fbdev (write)
[51.295316] Starting subtest: write
[53.011195] Subtest write: SUCCESS (1.744s)
[53.072167] [010/162] (951s left) gem_basic (bad-close)
[53.107460] Starting subtest: bad-close
[53.108871] Subtest bad-close: SUCCESS (0.000s)
[53.191419] [011/162] (951s left) gem_basic (create-close)
[53.218302] Starting subtest: create-close
[53.219736] Subtest create-close: SUCCESS (0.000s)
[53.339523] [012/162] (950s left) gem_basic (create-fd-close)
[53.367264] Starting subtest: create-fd-close
[53.368476] Subtest create-fd-close: SUCCESS (0.000s)
[53.468405] [013/162] (950s left) gem_busy (busy@all-engines)
[53.506362] Starting subtest: busy
[53.507072] Starting dynamic subtest: all-engines
[53.530569] Dynamic subtest all-engines: SUCCESS (0.024s)
[53.531365] Subtest busy: SUCCESS (0.025s)
[53.909673] [014/162] (950s left) gem_close_race (basic-process)
[53.943369] Starting subtest: basic-process
[53.989316] Subtest basic-process: SUCCESS (0.046s)
[54.175314] [015/162] (950s left) gem_close_race (basic-threads)
[54.208233] Starting subtest: basic-threads
[55.450872] Subtest basic-threads: SUCCESS (1.260s)
[55.639865] [016/162] (948s left) gem_ctx_create (basic)
[55.677317] Starting subtest: basic
[55.678127] Subtest basic: SUCCESS (0.000s)
[55.865900] [017/162] (948s left) gem_ctx_create (basic-files)
[55.896225] Starting subtest: basic-files
[57.904126] Subtest basic-files: SUCCESS (2.031s)
[58.241042] [018/162] (946s left) gem_ctx_exec (basic)
[58.275043] Starting subtest: basic
[58.276883] Subtest basic: SUCCESS (0.002s)
[58.386581] [019/162] (946s left) gem_exec_basic (basic)
[58.415505] Starting subtest: basic
[58.416221] Starting dynamic subtest: rcs0-smem
[58.416903] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[58.422414] Starting dynamic subtest: bcs0-smem
[58.423072] Dynamic subtest bcs0-smem: SUCCESS (0.000s)
[58.428575] Starting dynamic subtest: vcs0-smem
[58.429218] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[58.434530] Starting dynamic subtest: vcs1-smem
[58.435168] Dynamic subtest vcs1-smem: SUCCESS (0.000s)
[58.440405] Starting dynamic subtest: vecs0-smem
[58.441060] Dynamic subtest vecs0-smem: SUCCESS (0.000s)
[58.441710] Subtest basic: SUCCESS (0.003s)
[58.600781] [020/162] (945s left) gem_exec_create (basic)
[58.637658] Starting subtest: basic
[58.638468] Starting dynamic subtest: smem
[60.727716] Dynamic subtest smem: SUCCESS (2.106s)
[60.728967] Subtest basic: SUCCESS (2.107s)
[60.919256] [021/162] (943s left) gem_exec_fence (basic-busy)
[61.068924] Starting subtest: basic-busy
[61.069835] Starting dynamic subtest: rcs0
[61.166295] Dynamic subtest rcs0: SUCCESS (0.100s)
[61.183124] Starting dynamic subtest: bcs0
[61.229115] Dynamic subtest bcs0: SUCCESS (0.062s)
[61.243743] Starting dynamic subtest: vcs0
[61.281156] Dynamic subtest vcs0: SUCCESS (0.051s)
[61.296670] Starting dynamic subtest: vcs1
[61.338061] Dynamic subtest vcs1: SUCCESS (0.056s)
[61.351916] Starting dynamic subtest: vecs0
[61.397628] Dynamic subtest vecs0: SUCCESS (0.058s)
[61.399326] Subtest basic-busy: SUCCESS (0.334s)
[61.975788] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[61.977804] [022/162] (942s left) gem_exec_fence (basic-wait)
[62.136156] Starting subtest: basic-wait
[62.137325] Starting dynamic subtest: rcs0
[62.215194] Dynamic subtest rcs0: SUCCESS (0.081s)
[62.225072] Starting dynamic subtest: bcs0
[62.271181] Dynamic subtest bcs0: SUCCESS (0.055s)
[62.285895] Starting dynamic subtest: vcs0
[62.322116] Dynamic subtest vcs0: SUCCESS (0.050s)
[62.331968] Starting dynamic subtest: vcs1
[62.373887] Dynamic subtest vcs1: SUCCESS (0.050s)
[62.387191] Starting dynamic subtest: vecs0
[62.424397] Dynamic subtest vecs0: SUCCESS (0.050s)
[62.426153] Subtest basic-wait: SUCCESS (0.293s)
[62.941354] [023/162] (941s left) gem_exec_fence (basic-await)
[63.092755] Starting subtest: basic-await
[63.093709] Starting dynamic subtest: rcs0
[63.164283] Dynamic subtest rcs0: SUCCESS (0.074s)
[63.176059] Starting dynamic subtest: bcs0
[63.240666] Dynamic subtest bcs0: SUCCESS (0.075s)
[63.249859] Starting dynamic subtest: vcs0
[63.312842] Dynamic subtest vcs0: SUCCESS (0.072s)
[63.320205] Starting dynamic subtest: vcs1
[63.384882] Dynamic subtest vcs1: SUCCESS (0.071s)
[63.393869] Starting dynamic subtest: vecs0
[63.457866] Dynamic subtest vecs0: SUCCESS (0.072s)
[63.459512] Subtest basic-await: SUCCESS (0.370s)
[63.971949] [024/162] (940s left) gem_exec_fence (nb-await)
[64.123133] Starting subtest: nb-await
[64.123878] Starting dynamic subtest: rcs0
[64.179482] Dynamic subtest rcs0: SUCCESS (0.058s)
[64.193466] Starting dynamic subtest: bcs0
[64.240324] Dynamic subtest bcs0: SUCCESS (0.060s)
[64.249969] Starting dynamic subtest: vcs0
[64.301954] Dynamic subtest vcs0: SUCCESS (0.061s)
[64.308989] Starting dynamic subtest: vcs1
[64.358264] Dynamic subtest vcs1: SUCCESS (0.055s)
[64.373015] Starting dynamic subtest: vecs0
[64.421529] Dynamic subtest vecs0: SUCCESS (0.062s)
[64.423033] Subtest nb-await: SUCCESS (0.301s)
[64.933789] [025/162] (939s left) gem_exec_gttfill (basic)
[64.973507] Starting subtest: basic
[67.649031] Subtest basic: SUCCESS (2.675s)
[67.831832] [026/162] (936s left) gem_exec_parallel (engines)
[67.958231] Starting subtest: engines
[67.958953] Starting dynamic subtest: basic
[69.316110] Dynamic subtest basic: SUCCESS (1.361s)
[69.323335] Starting dynamic subtest: contexts
[71.126142] Dynamic subtest contexts: SUCCESS (1.804s)
[71.132635] Starting dynamic subtest: fds
[72.958785] Dynamic subtest fds: SUCCESS (1.835s)
[72.965659] Starting dynamic subtest: userptr
[74.279955] Dynamic subtest userptr: SUCCESS (1.332s)
[74.280960] Subtest engines: SUCCESS (6.333s)
[74.492882] [027/162] (930s left) gem_exec_store (basic)
[74.525734] Starting subtest: basic
[74.606141] Subtest basic: SUCCESS (0.079s)
[74.807924] [028/162] (929s left) gem_flink_basic (bad-flink)
[74.833292] Starting subtest: bad-flink
[74.833941] Subtest bad-flink: SUCCESS (0.000s)
[74.906129] [029/162] (929s left) gem_flink_basic (bad-open)
[74.931486] Starting subtest: bad-open
[74.932244] Subtest bad-open: SUCCESS (0.000s)
[75.007348] [030/162] (929s left) gem_flink_basic (basic)
[75.032888] Starting subtest: basic
[75.033598] Subtest basic: SUCCESS (0.000s)
[75.177429] [031/162] (929s left) gem_flink_basic (double-flink)
[75.202145] Starting subtest: double-flink
[75.202855] Subtest double-flink: SUCCESS (0.000s)
[75.329657] [032/162] (929s left) gem_flink_basic (flink-lifetime)
[75.357902] Starting subtest: flink-lifetime
[75.358587] Subtest flink-lifetime: SUCCESS (0.001s)
[75.460077] [033/162] (929s left) gem_huc_copy (huc-copy)
[75.492486] Starting subtest: huc-copy
[75.494304] Subtest huc-copy: SUCCESS (0.002s)
[75.611363] [034/162] (929s left) gem_linear_blits (basic)
[75.731778] Starting subtest: basic
[75.737979] Subtest basic: SUCCESS (0.006s)
[75.909923] [035/162] (929s left) gem_mmap (basic)
[75.976623] Starting subtest: basic
[75.979830] Subtest basic: SUCCESS (0.000s)
[76.094144] [036/162] (928s left) gem_mmap_gtt (basic)
[76.120669] Starting subtest: basic
[76.121286] Subtest basic: SUCCESS (0.000s)
[76.242918] [037/162] (928s left) gem_render_linear_blits (basic)
[76.277655] Starting subtest: basic
[76.298311] Subtest basic: SUCCESS (0.021s)
[76.383102] [038/162] (928s left) gem_render_tiled_blits (basic)
[76.411165] Starting subtest: basic
[76.432780] Subtest basic: SUCCESS (0.022s)
[76.516126] [039/162] (928s left) gem_ringfill (basic-all)
[76.859551] Starting subtest: basic-all
[77.976218] Subtest basic-all: SUCCESS (1.110s)
[78.129422] [040/162] (927s left) gem_softpin (allocator-basic)
[78.161132] Starting subtest: allocator-basic
[78.216035] Subtest allocator-basic: SUCCESS (0.055s)
[78.378097] [041/162] (926s left) gem_softpin (allocator-basic-reserve)
[78.408495] Starting subtest: allocator-basic-reserve
[78.463788] Subtest allocator-basic-reserve: SUCCESS (0.055s)
[78.592851] [042/162] (926s left) gem_softpin (safe-alignment)
[78.624871] Starting subtest: safe-alignment
[78.632476] Subtest safe-alignment: SUCCESS (0.008s)
[78.742133] [043/162] (926s left) gem_sync (basic-all)
[78.775192] Starting subtest: basic-all
[81.317095] Subtest basic-all: SUCCESS (2.540s)
[81.511805] [044/162] (923s left) gem_sync (basic-each)
[81.544735] Starting subtest: basic-each
[83.824750] Subtest basic-each: SUCCESS (2.279s)
[84.014894] [045/162] (921s left) gem_tiled_blits (basic)
[84.115908] Starting subtest: basic
[84.123945] Subtest basic: SUCCESS (0.009s)
[84.271711] [046/162] (921s left) gem_tiled_fence_blits (basic)
[84.402909] Starting subtest: basic
[84.419878] Subtest basic: SUCCESS (0.017s)
[84.570130] [047/162] (920s left) gem_tiled_pread_basic (basic)
[84.630070] Subtest basic: SKIP (0.000s)
[84.682650] [048/162] (920s left) gem_wait (busy@all-engines)
[84.721025] Starting subtest: busy
[84.721739] Starting dynamic subtest: all-engines
[85.261907] Dynamic subtest all-engines: SUCCESS (0.540s)
[85.262976] Subtest busy: SUCCESS (0.541s)
[85.478139] [049/162] (919s left) gem_wait (wait@all-engines)
[85.511980] Starting subtest: wait
[85.512843] Starting dynamic subtest: all-engines
[86.580460] Dynamic subtest all-engines: SUCCESS (1.067s)
[86.582118] Subtest wait: SUCCESS (1.068s)
[86.795752] [050/162] (918s left) i915_getparams_basic (basic-eu-total)
[86.824284] Starting subtest: basic-eu-total
[86.825548] Subtest basic-eu-total: SUCCESS (0.000s)
[86.909853] [051/162] (918s left) i915_getparams_basic (basic-subslice-total)
[86.935914] Starting subtest: basic-subslice-total
[86.937292] Subtest basic-subslice-total: SUCCESS (0.000s)
[87.012977] [052/162] (918s left) i915_hangman (error-state-basic)
[87.051573] Starting subtest: error-state-basic
[87.142067] Subtest error-state-basic: SUCCESS (0.090s)
[87.246698] [053/162] (918s left) i915_pciid
[87.363793] [054/162] (918s left) intel_hwmon (hwmon-read)
[87.394641] Subtest hwmon-read: SKIP (0.000s)
[87.434702] [055/162] (918s left) intel_hwmon (hwmon-write)
[87.461217] Subtest hwmon-write: SKIP (0.000s)
[87.509256] [056/162] (918s left) kms_addfb_basic (addfb25-4-tiled)
[88.968192] Starting subtest: addfb25-4-tiled
[88.968920] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[89.096717] [057/162] (916s left) kms_addfb_basic (addfb25-bad-modifier)
[90.537965] Starting subtest: addfb25-bad-modifier
[90.538909] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[90.646154] [058/162] (915s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[92.091213] Starting subtest: addfb25-framebuffer-vs-set-tiling
[92.091947] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[92.217167] [059/162] (913s left) kms_addfb_basic (addfb25-modifier-no-flag)
[93.658810] Starting subtest: addfb25-modifier-no-flag
[93.659562] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[93.762408] [060/162] (912s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[95.205082] Starting subtest: addfb25-x-tiled-legacy
[95.205985] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[95.302504] [061/162] (910s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[96.746055] Starting subtest: addfb25-x-tiled-mismatch-legacy
[96.746876] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[96.848461] [062/162] (909s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[98.295990] Starting subtest: addfb25-yf-tiled-legacy
[98.296796] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[98.431618] [063/162] (907s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[99.878076] Starting subtest: addfb25-y-tiled-legacy
[99.878980] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[99.981370] [064/162] (905s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[101.431162] Starting subtest: addfb25-y-tiled-small-legacy
[101.431933] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s)
[101.548252] [065/162] (904s left) kms_addfb_basic (bad-pitch-0)
[101.576301] Starting subtest: bad-pitch-0
[101.576963] Subtest bad-pitch-0: SUCCESS (0.000s)
[103.117304] [066/162] (902s left) kms_addfb_basic (bad-pitch-1024)
[103.155998] Starting subtest: bad-pitch-1024
[103.156666] Subtest bad-pitch-1024: SUCCESS (0.000s)
[104.681328] [067/162] (901s left) kms_addfb_basic (bad-pitch-128)
[104.707134] Starting subtest: bad-pitch-128
[104.707764] Subtest bad-pitch-128: SUCCESS (0.000s)
[106.269844] [068/162] (899s left) kms_addfb_basic (bad-pitch-256)
[106.294658] Starting subtest: bad-pitch-256
[106.295588] Subtest bad-pitch-256: SUCCESS (0.000s)
[107.832785] [069/162] (898s left) kms_addfb_basic (bad-pitch-32)
[107.862127] Starting subtest: bad-pitch-32
[107.862826] Subtest bad-pitch-32: SUCCESS (0.000s)
[109.401932] [070/162] (896s left) kms_addfb_basic (bad-pitch-63)
[109.434982] Starting subtest: bad-pitch-63
[109.435671] Subtest bad-pitch-63: SUCCESS (0.000s)
[110.948797] [071/162] (895s left) kms_addfb_basic (bad-pitch-65536)
[110.977324] Starting subtest: bad-pitch-65536
[110.978101] Subtest bad-pitch-65536: SUCCESS (0.000s)
[112.500101] [072/162] (893s left) kms_addfb_basic (bad-pitch-999)
[112.529042] Starting subtest: bad-pitch-999
[112.529728] Subtest bad-pitch-999: SUCCESS (0.000s)
[114.055506] [073/162] (892s left) kms_addfb_basic (basic)
[114.081396] Starting subtest: basic
[114.082069] Subtest basic: SUCCESS (0.000s)
[115.618679] [074/162] (890s left) kms_addfb_basic (basic-x-tiled-legacy)
[115.649652] Starting subtest: basic-x-tiled-legacy
[115.650465] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[117.172822] [075/162] (889s left) kms_addfb_basic (basic-y-tiled-legacy)
[117.205802] Starting subtest: basic-y-tiled-legacy
[117.206471] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[118.728944] [076/162] (887s left) kms_addfb_basic (bo-too-small)
[120.172989] Starting subtest: bo-too-small
[120.173803] Subtest bo-too-small: SUCCESS (0.000s)
[120.286362] [077/162] (886s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[121.729040] Starting subtest: bo-too-small-due-to-tiling
[121.729888] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[121.853750] [078/162] (884s left) kms_addfb_basic (clobberred-modifier)
[121.881251] Starting subtest: clobberred-modifier
[121.881945] Subtest clobberred-modifier: SUCCESS (0.000s)
[123.399116] [079/162] (883s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[123.426130] Starting subtest: framebuffer-vs-set-tiling
[123.426808] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[124.988065] [080/162] (881s left) kms_addfb_basic (invalid-get-prop)
[125.014612] Starting subtest: invalid-get-prop
[125.015283] Subtest invalid-get-prop: SUCCESS (0.000s)
[126.533788] [081/162] (879s left) kms_addfb_basic (invalid-get-prop-any)
[126.562131] Starting subtest: invalid-get-prop-any
[126.562798] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[128.103094] [082/162] (878s left) kms_addfb_basic (invalid-set-prop)
[128.134470] Starting subtest: invalid-set-prop
[128.135173] Subtest invalid-set-prop: SUCCESS (0.000s)
[129.657145] [083/162] (876s left) kms_addfb_basic (invalid-set-prop-any)
[129.688697] Starting subtest: invalid-set-prop-any
[129.689391] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[131.221847] [084/162] (875s left) kms_addfb_basic (no-handle)
[131.256797] Starting subtest: no-handle
[131.257640] Subtest no-handle: SUCCESS (0.000s)
[132.803823] [085/162] (873s left) kms_addfb_basic (size-max)
[134.259945] Starting subtest: size-max
[134.260809] Subtest size-max: SUCCESS (0.000s)
[134.357792] [086/162] (872s left) kms_addfb_basic (small-bo)
[135.802066] Starting subtest: small-bo
[135.802865] Subtest small-bo: SUCCESS (0.000s)
[135.900773] [087/162] (870s left) kms_addfb_basic (tile-pitch-mismatch)
[135.928716] Starting subtest: tile-pitch-mismatch
[135.929602] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[137.435274] [088/162] (869s left) kms_addfb_basic (too-high)
[138.879160] Starting subtest: too-high
[138.880047] Subtest too-high: SUCCESS (0.001s)
[138.992469] [089/162] (867s left) kms_addfb_basic (too-wide)
[140.436357] Starting subtest: too-wide
[140.437164] Subtest too-wide: SUCCESS (0.000s)
[140.555357] [090/162] (866s left) kms_addfb_basic (unused-handle)
[140.582830] Starting subtest: unused-handle
[140.583573] Subtest unused-handle: SUCCESS (0.000s)
[142.090262] [091/162] (864s left) kms_addfb_basic (unused-modifier)
[142.128175] Starting subtest: unused-modifier
[142.128915] Subtest unused-modifier: SUCCESS (0.000s)
[143.690335] [092/162] (863s left) kms_addfb_basic (unused-offsets)
[143.723977] Starting subtest: unused-offsets
[143.724663] Subtest unused-offsets: SUCCESS (0.000s)
[145.295901] [093/162] (861s left) kms_addfb_basic (unused-pitches)
[145.322443] Starting subtest: unused-pitches
[145.323095] Subtest unused-pitches: SUCCESS (0.000s)
[146.848397] [094/162] (860s left) kms_busy (basic)
[148.296685] Starting subtest: basic
[148.297293] Starting dynamic subtest: flip
[148.788741] Dynamic subtest flip: SUCCESS (0.492s)
[148.796307] Starting dynamic subtest: modeset
[149.566392] Dynamic subtest modeset: SUCCESS (0.777s)
[149.567154] Subtest basic: SUCCESS (1.270s)
[149.774133] [095/162] (857s left) kms_prop_blob (basic)
[149.802010] Starting subtest: basic
[149.802718] Subtest basic: SUCCESS (0.000s)
[149.911108] [096/162] (857s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[151.364803] Starting subtest: basic-busy-flip-before-cursor-atomic
[151.366293] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[151.460029] [097/162] (855s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[152.900991] Starting subtest: basic-busy-flip-before-cursor-legacy
[152.902604] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[152.988145] [098/162] (854s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[154.433927] Starting subtest: basic-flip-after-cursor-atomic
[155.410179] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.976s)
[155.593254] [099/162] (851s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[157.035045] Starting subtest: basic-flip-after-cursor-legacy
[158.014238] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.980s)
[158.201570] [100/162] (848s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[159.645079] Starting subtest: basic-flip-after-cursor-varying-size
[160.617335] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.973s)
[160.845307] [101/162] (846s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[162.285074] Starting subtest: basic-flip-before-cursor-atomic
[163.244585] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.959s)
[163.455140] [102/162] (843s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[164.906155] Starting subtest: basic-flip-before-cursor-legacy
[165.892181] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.987s)
[166.080205] [103/162] (841s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[167.523101] Starting subtest: basic-flip-before-cursor-varying-size
[168.503761] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.981s)
[168.697346] [104/162] (838s left) kms_dsc (dsc-basic)
[170.141064] Starting subtest: dsc-basic
[170.145413] Subtest dsc-basic: SKIP (0.000s)
[170.212680] [105/162] (837s left) kms_flip (basic-flip-vs-dpms)
[171.653808] Starting subtest: basic-flip-vs-dpms
[171.655545] Starting dynamic subtest: A-DP1
[172.527477] Dynamic subtest A-DP1: SUCCESS (0.873s)
[172.534904] Starting dynamic subtest: B-DP1
[173.269912] Dynamic subtest B-DP1: SUCCESS (0.741s)
[173.277637] Starting dynamic subtest: C-DP1
[174.015406] Dynamic subtest C-DP1: SUCCESS (0.745s)
[174.023582] Starting dynamic subtest: D-DP1
[174.761894] Dynamic subtest D-DP1: SUCCESS (0.745s)
[174.764739] Subtest basic-flip-vs-dpms: SUCCESS (3.112s)
[174.940877] [106/162] (832s left) kms_flip (basic-flip-vs-modeset)
[176.390876] Starting subtest: basic-flip-vs-modeset
[176.393950] Starting dynamic subtest: A-DP1
[177.287273] Dynamic subtest A-DP1: SUCCESS (0.893s)
[177.294761] Starting dynamic subtest: B-DP1
[178.052933] Dynamic subtest B-DP1: SUCCESS (0.765s)
[178.060447] Starting dynamic subtest: C-DP1
[178.813391] Dynamic subtest C-DP1: SUCCESS (0.759s)
[178.826676] Starting dynamic subtest: D-DP1
[179.575872] Dynamic subtest D-DP1: SUCCESS (0.761s)
[179.577889] Subtest basic-flip-vs-modeset: SUCCESS (3.186s)
[179.763603] [107/162] (827s left) kms_flip (basic-flip-vs-wf_vblank)
[181.212715] Starting subtest: basic-flip-vs-wf_vblank
[181.216170] Starting dynamic subtest: A-DP1
[182.291683] Dynamic subtest A-DP1: SUCCESS (1.074s)
[182.310412] Starting dynamic subtest: B-DP1
[183.322181] Dynamic subtest B-DP1: SUCCESS (1.025s)
[183.333076] Starting dynamic subtest: C-DP1
[184.352617] Dynamic subtest C-DP1: SUCCESS (1.027s)
[184.364543] Starting dynamic subtest: D-DP1
[185.385159] Dynamic subtest D-DP1: SUCCESS (1.030s)
[185.390273] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.177s)
[185.638750] [108/162] (821s left) kms_flip (basic-plain-flip)
[187.082966] Starting subtest: basic-plain-flip
[187.084844] Starting dynamic subtest: A-DP1
[187.875038] Dynamic subtest A-DP1: SUCCESS (0.789s)
[187.887860] Starting dynamic subtest: B-DP1
[188.626880] Dynamic subtest B-DP1: SUCCESS (0.749s)
[188.644909] Starting dynamic subtest: C-DP1
[189.374973] Dynamic subtest C-DP1: SUCCESS (0.744s)
[189.388936] Starting dynamic subtest: D-DP1
[190.127661] Dynamic subtest D-DP1: SUCCESS (0.748s)
[190.132305] Subtest basic-plain-flip: SUCCESS (3.049s)
[190.358696] [109/162] (817s left) kms_force_connector_basic (force-connector-state)
[190.420340] Starting subtest: force-connector-state
[192.080203] Subtest force-connector-state: SUCCESS (1.660s)
[193.709912] [110/162] (813s left) kms_force_connector_basic (force-edid)
[193.767917] Starting subtest: force-edid
[193.816758] Subtest force-edid: SUCCESS (0.049s)
[195.374475] [111/162] (812s left) kms_force_connector_basic (force-load-detect)
[195.430079] Starting subtest: force-load-detect
[195.431483] Subtest force-load-detect: SKIP (0.000s)
[196.245220] [112/162] (811s left) kms_force_connector_basic (prune-stale-modes)
[196.310506] Starting subtest: prune-stale-modes
[196.359612] Subtest prune-stale-modes: SUCCESS (0.050s)
[197.909415] [113/162] (809s left) kms_frontbuffer_tracking (basic)
[199.353298] Starting subtest: basic
[203.210311] Subtest basic: SUCCESS (3.857s)
[203.384410] [114/162] (804s left) kms_hdmi_inject (inject-audio)
[203.502814] Starting subtest: inject-audio
[203.637979] Subtest inject-audio: SUCCESS (0.136s)
[204.572300] [115/162] (803s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[206.015061] Starting subtest: compare-crc-sanitycheck-xr24
[206.015820] Starting dynamic subtest: pipe-A-DP-1
[206.458390] Dynamic subtest pipe-A-DP-1: SUCCESS (0.443s)
[206.467016] Starting dynamic subtest: pipe-B-DP-1
[206.877951] Dynamic subtest pipe-B-DP-1: SUCCESS (0.418s)
[206.887908] Starting dynamic subtest: pipe-C-DP-1
[207.276691] Dynamic subtest pipe-C-DP-1: SUCCESS (0.398s)
[207.285374] Starting dynamic subtest: pipe-D-DP-1
[207.680492] Dynamic subtest pipe-D-DP-1: SUCCESS (0.402s)
[207.681157] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.666s)
[207.861970] [116/162] (799s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[209.303694] Starting subtest: compare-crc-sanitycheck-nv12
[209.304575] Starting dynamic subtest: pipe-A-DP-1
[209.921613] Dynamic subtest pipe-A-DP-1: SUCCESS (0.617s)
[209.930441] Starting dynamic subtest: pipe-B-DP-1
[210.489308] Dynamic subtest pipe-B-DP-1: SUCCESS (0.566s)
[210.500906] Starting dynamic subtest: pipe-C-DP-1
[211.040907] Dynamic subtest pipe-C-DP-1: SUCCESS (0.549s)
[211.049594] Starting dynamic subtest: pipe-D-DP-1
[211.613976] Dynamic subtest pipe-D-DP-1: SUCCESS (0.571s)
[211.614700] Subtest compare-crc-sanitycheck-nv12: SUCCESS (2.311s)
[211.817583] [117/162] (795s left) kms_pipe_crc_basic (hang-read-crc)
[213.260331] Starting subtest: hang-read-crc
[213.261145] Starting dynamic subtest: pipe-A-DP-1
[214.486898] Dynamic subtest pipe-A-DP-1: SUCCESS (1.226s)
[214.495098] Starting dynamic subtest: pipe-B-DP-1
[215.581202] Dynamic subtest pipe-B-DP-1: SUCCESS (1.093s)
[215.590166] Starting dynamic subtest: pipe-C-DP-1
[216.689587] Dynamic subtest pipe-C-DP-1: SUCCESS (1.106s)
[216.697614] Starting dynamic subtest: pipe-D-DP-1
[217.820761] Dynamic subtest pipe-D-DP-1: SUCCESS (1.130s)
[217.821540] Subtest hang-read-crc: SUCCESS (4.562s)
[217.980811] [118/162] (789s left) kms_pipe_crc_basic (nonblocking-crc)
[219.429522] Starting subtest: nonblocking-crc
[219.431606] Starting dynamic subtest: pipe-A-DP-1
[220.068436] Dynamic subtest pipe-A-DP-1: SUCCESS (0.637s)
[220.076716] Starting dynamic subtest: pipe-B-DP-1
[220.630620] Dynamic subtest pipe-B-DP-1: SUCCESS (0.560s)
[220.639081] Starting dynamic subtest: pipe-C-DP-1
[221.212834] Dynamic subtest pipe-C-DP-1: SUCCESS (0.580s)
[221.220211] Starting dynamic subtest: pipe-D-DP-1
[221.775608] Dynamic subtest pipe-D-DP-1: SUCCESS (0.562s)
[221.776417] Subtest nonblocking-crc: SUCCESS (2.346s)
[221.968534] [119/162] (785s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[223.417528] Starting subtest: nonblocking-crc-frame-sequence
[223.418276] Starting dynamic subtest: pipe-A-DP-1
[224.057670] Dynamic subtest pipe-A-DP-1: SUCCESS (0.640s)
[224.069335] Starting dynamic subtest: pipe-B-DP-1
[224.634213] Dynamic subtest pipe-B-DP-1: SUCCESS (0.575s)
[224.642523] Starting dynamic subtest: pipe-C-DP-1
[225.216165] Dynamic subtest pipe-C-DP-1: SUCCESS (0.580s)
[225.224368] Starting dynamic subtest: pipe-D-DP-1
[225.819264] Dynamic subtest pipe-D-DP-1: SUCCESS (0.601s)
[225.819951] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.402s)
[225.991218] [120/162] (781s left) kms_pipe_crc_basic (read-crc)
[227.438931] Starting subtest: read-crc
[227.439719] Starting dynamic subtest: pipe-A-DP-1
[227.987469] Dynamic subtest pipe-A-DP-1: SUCCESS (0.548s)
[227.996349] Starting dynamic subtest: pipe-B-DP-1
[228.484441] Dynamic subtest pipe-B-DP-1: SUCCESS (0.494s)
[228.493666] Starting dynamic subtest: pipe-C-DP-1
[228.979526] Dynamic subtest pipe-C-DP-1: SUCCESS (0.494s)
[228.988079] Starting dynamic subtest: pipe-D-DP-1
[229.474972] Dynamic subtest pipe-D-DP-1: SUCCESS (0.493s)
[229.475750] Subtest read-crc: SUCCESS (2.036s)
[229.635067] [121/162] (778s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[231.083502] Starting subtest: read-crc-frame-sequence
[231.085424] Starting dynamic subtest: pipe-A-DP-1
[231.673947] Dynamic subtest pipe-A-DP-1: SUCCESS (0.588s)
[231.682299] Starting dynamic subtest: pipe-B-DP-1
[232.164274] Dynamic subtest pipe-B-DP-1: SUCCESS (0.489s)
[232.172893] Starting dynamic subtest: pipe-C-DP-1
[232.680027] Dynamic subtest pipe-C-DP-1: SUCCESS (0.514s)
[232.688742] Starting dynamic subtest: pipe-D-DP-1
[233.180813] Dynamic subtest pipe-D-DP-1: SUCCESS (0.499s)
[233.181573] Subtest read-crc-frame-sequence: SUCCESS (2.097s)
[233.342181] [122/162] (774s left) kms_pm_backlight (basic-brightness)
[234.787008] Subtest basic-brightness: SKIP (0.000s)
[234.831346] [123/162] (773s left) kms_pm_rpm (basic-pci-d3-state)
[238.202961] Starting subtest: basic-pci-d3-state
[240.193621] Subtest basic-pci-d3-state: SUCCESS (1.992s)
[241.051429] [124/162] (766s left) kms_pm_rpm (basic-rte)
[241.090696] Starting subtest: basic-rte
[246.415047] Subtest basic-rte: SUCCESS (5.324s)
[249.135874] [125/162] (758s left) kms_psr (psr-primary-page-flip)
[250.579843] Subtest psr-primary-page-flip: SKIP (0.000s)
[250.629489] [126/162] (757s left) kms_psr (psr-cursor-plane-move)
[252.078169] Subtest psr-cursor-plane-move: SKIP (0.000s)
[252.129357] [127/162] (755s left) kms_psr (psr-sprite-plane-onoff)
[253.581684] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[253.629811] [128/162] (754s left) kms_psr (psr-primary-mmap-gtt)
[255.071220] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[255.119246] [129/162] (753s left) kms_setmode (basic-clone-single-crtc)
[255.151106] Starting subtest: basic-clone-single-crtc
[255.153071] Subtest basic-clone-single-crtc: SKIP (0.000s)
[255.242621] [130/162] (752s left) i915_pm_rps (basic-api)
[255.280542] Starting subtest: basic-api
[255.281742] Subtest basic-api: SKIP (0.000s)
[255.374780] [131/162] (752s left) prime_self_import (basic-llseek-bad)
[255.401605] Starting subtest: basic-llseek-bad
[255.403155] Subtest basic-llseek-bad: SUCCESS (0.001s)
[255.509250] [132/162] (752s left) prime_self_import (basic-llseek-size)
[255.540851] Starting subtest: basic-llseek-size
[255.542413] Subtest basic-llseek-size: SUCCESS (0.002s)
[255.660279] [133/162] (752s left) prime_self_import (basic-with_fd_dup)
[255.691737] Starting subtest: basic-with_fd_dup
[255.693461] Subtest basic-with_fd_dup: SUCCESS (0.002s)
[255.810438] [134/162] (752s left) prime_self_import (basic-with_one_bo)
[255.836529] Starting subtest: basic-with_one_bo
[255.839875] Subtest basic-with_one_bo: SUCCESS (0.003s)
[255.967479] [135/162] (752s left) prime_self_import (basic-with_one_bo_two_files)
[255.999248] Starting subtest: basic-with_one_bo_two_files
[256.000785] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s)
[256.108177] [136/162] (752s left) prime_self_import (basic-with_two_bos)
[256.134014] Starting subtest: basic-with_two_bos
[256.136969] Subtest basic-with_two_bos: SUCCESS (0.002s)
[256.242092] [137/162] (752s left) prime_vgem (basic-fence-flip)
[256.297872] Starting subtest: basic-fence-flip
[258.101500] Subtest basic-fence-flip: SUCCESS (1.804s)
[258.211955] [138/162] (750s left) prime_vgem (basic-fence-mmap)
[258.280884] Starting subtest: basic-fence-mmap
[258.298873] Subtest basic-fence-mmap: SUCCESS (0.018s)
[258.417349] [139/162] (750s left) prime_vgem (basic-fence-read)
[258.491654] Starting subtest: basic-fence-read
[258.505313] Subtest basic-fence-read: SKIP (0.003s)
[258.609367] [140/162] (749s left) prime_vgem (basic-gtt)
[258.656841] Starting subtest: basic-gtt
[258.664536] Subtest basic-gtt: SUCCESS (0.008s)
[258.783182] [141/162] (749s left) prime_vgem (basic-read)
[258.845959] Starting subtest: basic-read
[258.849417] Subtest basic-read: SKIP (0.003s)
[258.959181] [142/162] (749s left) prime_vgem (basic-write)
[259.014429] Starting subtest: basic-write
[259.018079] Subtest basic-write: SKIP (0.003s)
[259.124220] [143/162] (749s left) vgem_basic (setversion)
[259.170346] Starting subtest: setversion
[259.171707] Subtest setversion: SUCCESS (0.000s)
[259.261947] [144/162] (749s left) vgem_basic (create)
[259.302370] Starting subtest: create
[259.303147] Subtest create: SUCCESS (0.000s)
[259.372317] [145/162] (749s left) vgem_basic (debugfs)
[259.403429] Starting subtest: debugfs
[259.404277] Subtest debugfs: SUCCESS (0.000s)
[259.491428] [146/162] (749s left) vgem_basic (dmabuf-export)
[259.535899] Starting subtest: dmabuf-export
[259.559263] Subtest dmabuf-export: SUCCESS (0.022s)
[259.677984] [147/162] (749s left) vgem_basic (dmabuf-fence)
[259.719012] Starting subtest: dmabuf-fence
[259.719702] Subtest dmabuf-fence: SUCCESS (0.000s)
[259.788618] [148/162] (748s left) vgem_basic (dmabuf-fence-before)
[259.819577] Starting subtest: dmabuf-fence-before
[259.820224] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[259.909700] [149/162] (748s left) vgem_basic (dmabuf-mmap)
[259.952213] Starting subtest: dmabuf-mmap
[259.958265] Subtest dmabuf-mmap: SUCCESS (0.007s)
[260.020077] [150/162] (748s left) vgem_basic (mmap)
[260.069625] Starting subtest: mmap
[260.074654] Subtest mmap: SUCCESS (0.005s)
[260.139150] [151/162] (748s left) vgem_basic (second-client)
[260.169775] Starting subtest: second-client
[260.203243] Subtest second-client: SUCCESS (0.034s)
[260.275032] [152/162] (748s left) vgem_basic (sysfs)
[260.319271] Starting subtest: sysfs
[260.320031] Subtest sysfs: SUCCESS (0.000s)
[260.390296] [153/162] (748s left) core_hotunplug (unbind-rebind)
[260.451936] Starting subtest: unbind-rebind
[266.518395] Subtest unbind-rebind: SUCCESS (6.066s)
[266.549935] [154/162] (742s left) vgem_basic (unload)
[266.579414] Starting subtest: unload
[295.544340] Subtest unload: SUCCESS (28.929s)
[295.628432] [155/162] (713s left) i915_module_load (reload)
[295.660109] Starting subtest: reload
[302.028850] Subtest reload: SUCCESS (6.369s)
[302.069024] [156/162] (706s left) gem_lmem_swapping (basic)
[302.111739] Subtest basic: SKIP (0.000s)
[302.158753] [157/162] (706s left) gem_lmem_swapping (parallel-random-engines)
[302.192985] Subtest parallel-random-engines: SKIP (0.000s)
[302.244616] [158/162] (706s left) gem_lmem_swapping (random-engines)
[302.273946] Subtest random-engines: SKIP (0.000s)
[302.323619] [159/162] (706s left) gem_lmem_swapping (verify-random)
[302.352848] Subtest verify-random: SKIP (0.000s)
[302.394380] [160/162] (706s left) i915_pm_rpm (module-reload)
[305.907214] Starting subtest: module-reload
[321.150909] Subtest module-reload: SUCCESS (15.235s)
[321.180108] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[321.180899] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true
[321.184619] [161/162] (688s left) i915_selftest (live)