[28.970553] Initializing watchdogs
[28.970630]   /dev/watchdog0
[28.988501] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:a7ac Intel Alderlake_p (Gen12) Raptor Lake-U [Intel Graphics]
[28.994792] [001/162] (960s left) i915_module_load (load)
[29.048167] Starting subtest: load
[31.778401] Subtest load: SUCCESS (2.730s)
[31.823552] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[31.824793] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[31.839307] [002/162] (957s left) core_auth (basic-auth)
[31.909351] Starting subtest: basic-auth
[31.911856] Subtest basic-auth: SUCCESS (0.001s)
[32.040964] [003/162] (957s left) core_debugfs (read-all-entries)
[32.079659] Starting subtest: read-all-entries
[32.163410] Subtest read-all-entries: SUCCESS (0.085s)
[32.298437] [004/162] (957s left) core_sysfs (read-all-entries)
[32.341199] Starting subtest: read-all-entries
[32.343260] Subtest read-all-entries: SUCCESS (0.004s)
[32.449590] [005/162] (957s left) fbdev (eof)
[32.498592] Starting subtest: eof
[32.500977] Subtest eof: SUCCESS (0.001s)
[32.619405] [006/162] (957s left) fbdev (info)
[32.655234] Starting subtest: info
[32.657362] Subtest info: SUCCESS (0.000s)
[32.745303] [007/162] (957s left) fbdev (nullptr)
[32.795221] Starting subtest: nullptr
[32.797386] Subtest nullptr: SUCCESS (0.000s)
[32.875305] [008/162] (956s left) fbdev (read)
[32.927575] Starting subtest: read
[33.731196] Subtest read: SUCCESS (0.799s)
[33.812943] [009/162] (956s left) fbdev (write)
[33.862997] Starting subtest: write
[34.392851] Subtest write: SUCCESS (0.527s)
[34.444140] [010/162] (955s left) gem_basic (bad-close)
[34.482602] Starting subtest: bad-close
[34.485931] Subtest bad-close: SUCCESS (0.000s)
[34.576819] [011/162] (955s left) gem_basic (create-close)
[34.612966] Starting subtest: create-close
[34.615934] Subtest create-close: SUCCESS (0.000s)
[34.709575] [012/162] (955s left) gem_basic (create-fd-close)
[34.741891] Starting subtest: create-fd-close
[34.745154] Subtest create-fd-close: SUCCESS (0.000s)
[34.861373] [013/162] (955s left) gem_busy (busy@all-engines)
[34.916021] Starting subtest: busy
[34.918004] Starting dynamic subtest: all-engines
[34.944365] Dynamic subtest all-engines: SUCCESS (0.030s)
[34.946563] Subtest busy: SUCCESS (0.031s)
[35.335446] [014/162] (954s left) gem_close_race (basic-process)
[35.380821] Starting subtest: basic-process
[35.401937] Subtest basic-process: SUCCESS (0.021s)
[35.617426] [015/162] (954s left) gem_close_race (basic-threads)
[35.663333] Starting subtest: basic-threads
[36.868675] Subtest basic-threads: SUCCESS (1.204s)
[37.072600] [016/162] (953s left) gem_ctx_create (basic)
[37.120287] Starting subtest: basic
[37.122079] Subtest basic: SUCCESS (0.000s)
[37.341761] [017/162] (952s left) gem_ctx_create (basic-files)
[37.384719] Starting subtest: basic-files
[39.394161] Subtest basic-files: SUCCESS (2.010s)
[39.630665] [018/162] (950s left) gem_ctx_exec (basic)
[39.684316] Starting subtest: basic
[39.688880] Subtest basic: SUCCESS (0.006s)
[39.814530] [019/162] (950s left) gem_exec_basic (basic)
[39.855825] Starting subtest: basic
[39.857440] Starting dynamic subtest: rcs0-smem
[39.859167] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[39.866832] Starting dynamic subtest: bcs0-smem
[39.868782] Dynamic subtest bcs0-smem: SUCCESS (0.000s)
[39.876128] Starting dynamic subtest: vcs0-smem
[39.878225] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[39.885628] Starting dynamic subtest: vcs1-smem
[39.887676] Dynamic subtest vcs1-smem: SUCCESS (0.000s)
[39.895136] Starting dynamic subtest: vecs0-smem
[39.897136] Dynamic subtest vecs0-smem: SUCCESS (0.000s)
[39.899108] Subtest basic: SUCCESS (0.004s)
[40.063552] [020/162] (950s left) gem_exec_create (basic)
[40.103155] Starting subtest: basic
[40.105251] Starting dynamic subtest: smem
[42.195876] Dynamic subtest smem: SUCCESS (2.091s)
[42.199220] Subtest basic: SUCCESS (2.092s)
[42.397075] [021/162] (948s left) gem_exec_fence (basic-busy)
[42.571175] Starting subtest: basic-busy
[42.573109] Starting dynamic subtest: rcs0
[42.658927] Dynamic subtest rcs0: SUCCESS (0.086s)
[42.675487] Starting dynamic subtest: bcs0
[42.712837] Dynamic subtest bcs0: SUCCESS (0.051s)
[42.727481] Starting dynamic subtest: vcs0
[42.767802] Dynamic subtest vcs0: SUCCESS (0.054s)
[42.782324] Starting dynamic subtest: vcs1
[42.822801] Dynamic subtest vcs1: SUCCESS (0.054s)
[42.837513] Starting dynamic subtest: vecs0
[42.873928] Dynamic subtest vecs0: SUCCESS (0.052s)
[42.876652] Subtest basic-busy: SUCCESS (0.303s)
[43.430545] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[43.433603] [022/162] (947s left) gem_exec_fence (basic-wait)
[43.596813] Starting subtest: basic-wait
[43.598724] Starting dynamic subtest: rcs0
[43.685112] Dynamic subtest rcs0: SUCCESS (0.086s)
[43.703951] Starting dynamic subtest: bcs0
[43.743058] Dynamic subtest bcs0: SUCCESS (0.057s)
[43.759263] Starting dynamic subtest: vcs0
[43.799791] Dynamic subtest vcs0: SUCCESS (0.056s)
[43.816104] Starting dynamic subtest: vcs1
[43.852885] Dynamic subtest vcs1: SUCCESS (0.052s)
[43.868625] Starting dynamic subtest: vecs0
[43.907593] Dynamic subtest vecs0: SUCCESS (0.054s)
[43.910729] Subtest basic-wait: SUCCESS (0.311s)
[44.449319] [023/162] (946s left) gem_exec_fence (basic-await)
[44.614267] Starting subtest: basic-await
[44.616957] Starting dynamic subtest: rcs0
[44.698907] Dynamic subtest rcs0: SUCCESS (0.084s)
[44.712196] Starting dynamic subtest: bcs0
[44.777376] Dynamic subtest bcs0: SUCCESS (0.079s)
[44.793147] Starting dynamic subtest: vcs0
[44.857299] Dynamic subtest vcs0: SUCCESS (0.078s)
[44.874849] Starting dynamic subtest: vcs1
[44.943058] Dynamic subtest vcs1: SUCCESS (0.085s)
[44.959823] Starting dynamic subtest: vecs0
[45.026286] Dynamic subtest vecs0: SUCCESS (0.082s)
[45.029517] Subtest basic-await: SUCCESS (0.415s)
[45.550520] [024/162] (945s left) gem_exec_fence (nb-await)
[45.718959] Starting subtest: nb-await
[45.721125] Starting dynamic subtest: rcs0
[45.780147] Dynamic subtest rcs0: SUCCESS (0.062s)
[45.798168] Starting dynamic subtest: bcs0
[45.840786] Dynamic subtest bcs0: SUCCESS (0.060s)
[45.865259] Starting dynamic subtest: vcs0
[45.906472] Dynamic subtest vcs0: SUCCESS (0.065s)
[45.920999] Starting dynamic subtest: vcs1
[45.967235] Dynamic subtest vcs1: SUCCESS (0.058s)
[45.986255] Starting dynamic subtest: vecs0
[46.032702] Dynamic subtest vecs0: SUCCESS (0.065s)
[46.036147] Subtest nb-await: SUCCESS (0.317s)
[46.567113] [025/162] (944s left) gem_exec_gttfill (basic)
[46.615103] Starting subtest: basic
[49.062291] Subtest basic: SUCCESS (2.446s)
[49.274980] [026/162] (941s left) gem_exec_parallel (engines)
[49.399375] Starting subtest: engines
[49.400946] Starting dynamic subtest: basic
[50.905245] Dynamic subtest basic: SUCCESS (1.504s)
[50.922024] Starting dynamic subtest: contexts
[52.992282] Dynamic subtest contexts: SUCCESS (2.085s)
[53.009853] Starting dynamic subtest: fds
[55.080138] Dynamic subtest fds: SUCCESS (2.088s)
[55.095811] Starting dynamic subtest: userptr
[56.548418] Dynamic subtest userptr: SUCCESS (1.467s)
[56.551128] Subtest engines: SUCCESS (7.149s)
[56.799552] [027/162] (933s left) gem_exec_store (basic)
[56.856838] Starting subtest: basic
[56.943866] Subtest basic: SUCCESS (0.088s)
[57.151631] [028/162] (933s left) gem_flink_basic (bad-flink)
[57.200018] Starting subtest: bad-flink
[57.201887] Subtest bad-flink: SUCCESS (0.000s)
[57.274902] [029/162] (933s left) gem_flink_basic (bad-open)
[57.311792] Starting subtest: bad-open
[57.313912] Subtest bad-open: SUCCESS (0.000s)
[57.412217] [030/162] (933s left) gem_flink_basic (basic)
[57.450750] Starting subtest: basic
[57.452718] Subtest basic: SUCCESS (0.000s)
[57.565856] [031/162] (933s left) gem_flink_basic (double-flink)
[57.604853] Starting subtest: double-flink
[57.607080] Subtest double-flink: SUCCESS (0.000s)
[57.726308] [032/162] (933s left) gem_flink_basic (flink-lifetime)
[57.763575] Starting subtest: flink-lifetime
[57.765764] Subtest flink-lifetime: SUCCESS (0.001s)
[57.871248] [033/162] (933s left) gem_huc_copy (huc-copy)
[57.920408] Starting subtest: huc-copy
[57.923295] Subtest huc-copy: SUCCESS (0.002s)
[58.068493] [034/162] (933s left) gem_linear_blits (basic)
[58.182857] Starting subtest: basic
[58.189593] Subtest basic: SUCCESS (0.007s)
[58.334285] [035/162] (932s left) gem_mmap (basic)
[58.436851] Starting subtest: basic
[58.447671] Subtest basic: SUCCESS (0.000s)
[58.539095] [036/162] (932s left) gem_mmap_gtt (basic)
[58.577050] Starting subtest: basic
[58.578319] Subtest basic: SUCCESS (0.001s)
[58.707905] [037/162] (932s left) gem_render_linear_blits (basic)
[58.755399] Starting subtest: basic
[58.781783] Subtest basic: SUCCESS (0.026s)
[58.894211] [038/162] (932s left) gem_render_tiled_blits (basic)
[58.933753] Starting subtest: basic
[58.962227] Subtest basic: SUCCESS (0.028s)
[59.067473] [039/162] (932s left) gem_ringfill (basic-all)
[59.412299] Starting subtest: basic-all
[60.531769] Subtest basic-all: SUCCESS (1.120s)
[60.700707] [040/162] (930s left) gem_softpin (allocator-basic)
[60.750069] Starting subtest: allocator-basic
[60.815998] Subtest allocator-basic: SUCCESS (0.067s)
[60.946537] [041/162] (930s left) gem_softpin (allocator-basic-reserve)
[60.990899] Starting subtest: allocator-basic-reserve
[61.056715] Subtest allocator-basic-reserve: SUCCESS (0.066s)
[61.210125] [042/162] (930s left) gem_softpin (safe-alignment)
[61.250075] Starting subtest: safe-alignment
[61.259794] Subtest safe-alignment: SUCCESS (0.010s)
[61.394632] [043/162] (930s left) gem_sync (basic-all)
[61.455975] Starting subtest: basic-all
[63.777820] Subtest basic-all: SUCCESS (2.329s)
[63.999821] [044/162] (927s left) gem_sync (basic-each)
[64.048080] Starting subtest: basic-each
[66.274544] Subtest basic-each: SUCCESS (2.231s)
[66.474048] [045/162] (925s left) gem_tiled_blits (basic)
[66.557479] Starting subtest: basic
[66.568296] Subtest basic: SUCCESS (0.013s)
[66.703154] [046/162] (924s left) gem_tiled_fence_blits (basic)
[66.940753] Starting subtest: basic
[66.959593] Subtest basic: SUCCESS (0.020s)
[67.249306] [047/162] (924s left) gem_tiled_pread_basic (basic)
[67.344805] Subtest basic: SKIP (0.000s)
[67.451480] [048/162] (924s left) gem_wait (busy@all-engines)
[67.505165] Starting subtest: busy
[67.509632] Starting dynamic subtest: all-engines
[68.070609] Dynamic subtest all-engines: SUCCESS (0.564s)
[68.072855] Subtest busy: SUCCESS (0.565s)
[68.295234] [049/162] (923s left) gem_wait (wait@all-engines)
[68.348555] Starting subtest: wait
[68.350359] Starting dynamic subtest: all-engines
[69.405678] Dynamic subtest all-engines: SUCCESS (1.056s)
[69.408779] Subtest wait: SUCCESS (1.057s)
[69.624307] [050/162] (922s left) i915_getparams_basic (basic-eu-total)
[69.669016] Starting subtest: basic-eu-total
[69.672904] Subtest basic-eu-total: SUCCESS (0.000s)
[69.761648] [051/162] (922s left) i915_getparams_basic (basic-subslice-total)
[69.804190] Starting subtest: basic-subslice-total
[69.807558] Subtest basic-subslice-total: SUCCESS (0.000s)
[69.908057] [052/162] (922s left) i915_hangman (error-state-basic)
[69.957132] Starting subtest: error-state-basic
[70.061067] Subtest error-state-basic: SUCCESS (0.103s)
[70.162496] [053/162] (921s left) i915_pciid
[70.301352] [054/162] (921s left) intel_hwmon (hwmon-read)
[70.341596] Subtest hwmon-read: SKIP (0.000s)
[70.403855] [055/162] (921s left) intel_hwmon (hwmon-write)
[70.443724] Subtest hwmon-write: SKIP (0.000s)
[70.493438] [056/162] (921s left) kms_addfb_basic (addfb25-4-tiled)
[70.561861] Starting subtest: addfb25-4-tiled
[70.563330] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[70.701997] [057/162] (921s left) kms_addfb_basic (addfb25-bad-modifier)
[70.749243] Starting subtest: addfb25-bad-modifier
[70.750883] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[70.890553] [058/162] (921s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[70.958070] Starting subtest: addfb25-framebuffer-vs-set-tiling
[70.960411] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[71.087485] [059/162] (921s left) kms_addfb_basic (addfb25-modifier-no-flag)
[71.154882] Starting subtest: addfb25-modifier-no-flag
[71.156578] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[71.286305] [060/162] (921s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[71.335702] Starting subtest: addfb25-x-tiled-legacy
[71.337594] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[71.456266] [061/162] (920s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[71.505070] Starting subtest: addfb25-x-tiled-mismatch-legacy
[71.507387] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[71.624406] [062/162] (920s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[71.671751] Starting subtest: addfb25-yf-tiled-legacy
[71.673478] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[71.796991] [063/162] (920s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[71.864799] Starting subtest: addfb25-y-tiled-legacy
[71.866591] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[71.974284] [064/162] (920s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[72.029800] Starting subtest: addfb25-y-tiled-small-legacy
[72.031515] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s)
[72.164444] [065/162] (920s left) kms_addfb_basic (bad-pitch-0)
[72.215752] Starting subtest: bad-pitch-0
[72.217514] Subtest bad-pitch-0: SUCCESS (0.000s)
[72.343333] [066/162] (920s left) kms_addfb_basic (bad-pitch-1024)
[72.382175] Starting subtest: bad-pitch-1024
[72.384159] Subtest bad-pitch-1024: SUCCESS (0.000s)
[72.532535] [067/162] (920s left) kms_addfb_basic (bad-pitch-128)
[72.578459] Starting subtest: bad-pitch-128
[72.582906] Subtest bad-pitch-128: SUCCESS (0.000s)
[72.689594] [068/162] (920s left) kms_addfb_basic (bad-pitch-256)
[72.737264] Starting subtest: bad-pitch-256
[72.739331] Subtest bad-pitch-256: SUCCESS (0.000s)
[72.879415] [069/162] (919s left) kms_addfb_basic (bad-pitch-32)
[72.918104] Starting subtest: bad-pitch-32
[72.931609] Subtest bad-pitch-32: SUCCESS (0.000s)
[73.095351] [070/162] (919s left) kms_addfb_basic (bad-pitch-63)
[73.137286] Starting subtest: bad-pitch-63
[73.140793] Subtest bad-pitch-63: SUCCESS (0.000s)
[73.262776] [071/162] (919s left) kms_addfb_basic (bad-pitch-65536)
[73.299837] Starting subtest: bad-pitch-65536
[73.301952] Subtest bad-pitch-65536: SUCCESS (0.000s)
[73.430996] [072/162] (919s left) kms_addfb_basic (bad-pitch-999)
[73.475565] Starting subtest: bad-pitch-999
[73.477457] Subtest bad-pitch-999: SUCCESS (0.000s)
[73.643953] [073/162] (919s left) kms_addfb_basic (basic)
[73.694256] Starting subtest: basic
[73.696732] Subtest basic: SUCCESS (0.000s)
[73.825130] [074/162] (919s left) kms_addfb_basic (basic-x-tiled-legacy)
[73.868044] Starting subtest: basic-x-tiled-legacy
[73.870163] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[74.008206] [075/162] (919s left) kms_addfb_basic (basic-y-tiled-legacy)
[74.051994] Starting subtest: basic-y-tiled-legacy
[74.053937] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[74.172997] [076/162] (918s left) kms_addfb_basic (bo-too-small)
[74.219311] Starting subtest: bo-too-small
[74.221160] Subtest bo-too-small: SUCCESS (0.000s)
[74.350882] [077/162] (918s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[74.398872] Starting subtest: bo-too-small-due-to-tiling
[74.400519] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[74.529858] [078/162] (918s left) kms_addfb_basic (clobberred-modifier)
[74.576584] Starting subtest: clobberred-modifier
[74.578193] Subtest clobberred-modifier: SUCCESS (0.000s)
[74.710268] [079/162] (918s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[74.757954] Starting subtest: framebuffer-vs-set-tiling
[74.759758] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[74.909921] [080/162] (918s left) kms_addfb_basic (invalid-get-prop)
[74.954745] Starting subtest: invalid-get-prop
[74.956702] Subtest invalid-get-prop: SUCCESS (0.000s)
[75.090405] [081/162] (918s left) kms_addfb_basic (invalid-get-prop-any)
[75.129769] Starting subtest: invalid-get-prop-any
[75.131671] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[75.251250] [082/162] (918s left) kms_addfb_basic (invalid-set-prop)
[75.293916] Starting subtest: invalid-set-prop
[75.295861] Subtest invalid-set-prop: SUCCESS (0.000s)
[75.421105] [083/162] (918s left) kms_addfb_basic (invalid-set-prop-any)
[75.468059] Starting subtest: invalid-set-prop-any
[75.469950] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[75.628498] [084/162] (917s left) kms_addfb_basic (no-handle)
[75.673604] Starting subtest: no-handle
[75.675284] Subtest no-handle: SUCCESS (0.000s)
[75.813352] [085/162] (917s left) kms_addfb_basic (size-max)
[75.873989] Starting subtest: size-max
[75.875754] Subtest size-max: SUCCESS (0.000s)
[75.994868] [086/162] (917s left) kms_addfb_basic (small-bo)
[76.058872] Starting subtest: small-bo
[76.060711] Subtest small-bo: SUCCESS (0.000s)
[76.213355] [087/162] (917s left) kms_addfb_basic (tile-pitch-mismatch)
[76.260066] Starting subtest: tile-pitch-mismatch
[76.262081] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[76.409375] [088/162] (917s left) kms_addfb_basic (too-high)
[76.459954] Starting subtest: too-high
[76.461833] Subtest too-high: SUCCESS (0.001s)
[76.576529] [089/162] (917s left) kms_addfb_basic (too-wide)
[76.642009] Starting subtest: too-wide
[76.643713] Subtest too-wide: SUCCESS (0.000s)
[76.756184] [090/162] (917s left) kms_addfb_basic (unused-handle)
[76.805912] Starting subtest: unused-handle
[76.808285] Subtest unused-handle: SUCCESS (0.000s)
[76.922355] [091/162] (916s left) kms_addfb_basic (unused-modifier)
[76.962099] Starting subtest: unused-modifier
[76.964933] Subtest unused-modifier: SUCCESS (0.000s)
[77.092731] [092/162] (916s left) kms_addfb_basic (unused-offsets)
[77.140791] Starting subtest: unused-offsets
[77.142701] Subtest unused-offsets: SUCCESS (0.000s)
[77.281192] [093/162] (916s left) kms_addfb_basic (unused-pitches)
[77.329426] Starting subtest: unused-pitches
[77.331402] Subtest unused-pitches: SUCCESS (0.000s)
[77.454522] [094/162] (916s left) kms_busy (basic)
[77.521109] Starting subtest: basic
[77.523095] Starting dynamic subtest: flip
[78.283777] Dynamic subtest flip: SUCCESS (0.760s)
[78.296092] Starting dynamic subtest: modeset
[81.861735] Dynamic subtest modeset: SUCCESS (3.579s)
[81.863227] Subtest basic: SUCCESS (4.341s)
[82.725192] [095/162] (911s left) kms_prop_blob (basic)
[82.768989] Starting subtest: basic
[82.770751] Subtest basic: SUCCESS (0.000s)
[82.897961] [096/162] (911s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[82.960573] Starting subtest: basic-busy-flip-before-cursor-atomic
[82.966458] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[83.061578] [097/162] (911s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[83.119100] Starting subtest: basic-busy-flip-before-cursor-legacy
[83.122556] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[83.213872] [098/162] (911s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[83.281503] Starting subtest: basic-flip-after-cursor-atomic
[84.480387] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.198s)
[85.424667] [099/162] (908s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[85.476191] Starting subtest: basic-flip-after-cursor-legacy
[86.673768] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.197s)
[87.543976] [100/162] (906s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[87.595753] Starting subtest: basic-flip-after-cursor-varying-size
[88.795170] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.198s)
[89.690460] [101/162] (904s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[89.756300] Starting subtest: basic-flip-before-cursor-atomic
[90.963857] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.205s)
[91.829704] [102/162] (902s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[91.890905] Starting subtest: basic-flip-before-cursor-legacy
[93.109068] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.214s)
[93.986608] [103/162] (900s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[94.055236] Starting subtest: basic-flip-before-cursor-varying-size
[95.253016] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.198s)
[96.138814] [104/162] (898s left) kms_dsc (dsc-basic)
[96.204945] Starting subtest: dsc-basic
[96.219204] Subtest dsc-basic: SKIP (0.000s)
[96.338010] [105/162] (898s left) kms_flip (basic-flip-vs-dpms)
[96.402083] Starting subtest: basic-flip-vs-dpms
[96.404083] Starting dynamic subtest: A-eDP1
[99.073572] Dynamic subtest A-eDP1: SUCCESS (2.668s)
[99.084147] Starting dynamic subtest: B-eDP1
[101.351866] Dynamic subtest B-eDP1: SUCCESS (2.279s)
[101.370185] Starting dynamic subtest: C-eDP1
[103.626156] Dynamic subtest C-eDP1: SUCCESS (2.271s)
[103.643937] Starting dynamic subtest: D-eDP1
[105.882840] Dynamic subtest D-eDP1: SUCCESS (2.258s)
[105.884848] Subtest basic-flip-vs-dpms: SUCCESS (9.483s)
[106.746477] [106/162] (887s left) kms_flip (basic-flip-vs-modeset)
[106.803925] Starting subtest: basic-flip-vs-modeset
[106.805770] Starting dynamic subtest: A-eDP1
[109.468553] Dynamic subtest A-eDP1: SUCCESS (2.662s)
[109.486428] Starting dynamic subtest: B-eDP1
[111.742668] Dynamic subtest B-eDP1: SUCCESS (2.275s)
[111.760253] Starting dynamic subtest: C-eDP1
[114.024456] Dynamic subtest C-eDP1: SUCCESS (2.281s)
[114.039590] Starting dynamic subtest: D-eDP1
[116.295226] Dynamic subtest D-eDP1: SUCCESS (2.267s)
[116.297414] Subtest basic-flip-vs-modeset: SUCCESS (9.492s)
[117.161198] [107/162] (877s left) kms_flip (basic-flip-vs-wf_vblank)
[117.232897] Starting subtest: basic-flip-vs-wf_vblank
[117.234696] Starting dynamic subtest: A-eDP1
[119.214065] Dynamic subtest A-eDP1: SUCCESS (1.983s)
[119.230858] Starting dynamic subtest: B-eDP1
[121.234952] Dynamic subtest B-eDP1: SUCCESS (2.018s)
[121.251285] Starting dynamic subtest: C-eDP1
[123.263381] Dynamic subtest C-eDP1: SUCCESS (2.026s)
[123.281336] Starting dynamic subtest: D-eDP1
[125.302658] Dynamic subtest D-eDP1: SUCCESS (2.036s)
[125.309086] Subtest basic-flip-vs-wf_vblank: SUCCESS (8.081s)
[126.609554] [108/162] (868s left) kms_flip (basic-plain-flip)
[126.671679] Starting subtest: basic-plain-flip
[126.673223] Starting dynamic subtest: A-eDP1
[128.363216] Dynamic subtest A-eDP1: SUCCESS (1.691s)
[128.379928] Starting dynamic subtest: B-eDP1
[130.090873] Dynamic subtest B-eDP1: SUCCESS (1.725s)
[130.106907] Starting dynamic subtest: C-eDP1
[131.792649] Dynamic subtest C-eDP1: SUCCESS (1.697s)
[131.814306] Starting dynamic subtest: D-eDP1
[133.517978] Dynamic subtest D-eDP1: SUCCESS (1.725s)
[133.524316] Subtest basic-plain-flip: SUCCESS (6.853s)
[134.804275] [109/162] (860s left) kms_force_connector_basic (force-connector-state)
[134.852620] Subtest force-connector-state: SKIP (0.000s)
[134.919453] [110/162] (859s left) kms_force_connector_basic (force-edid)
[134.965870] Subtest force-edid: SKIP (0.000s)
[135.028467] [111/162] (859s left) kms_force_connector_basic (force-load-detect)
[135.077689] Subtest force-load-detect: SKIP (0.000s)
[135.134759] [112/162] (859s left) kms_force_connector_basic (prune-stale-modes)
[135.190401] Subtest prune-stale-modes: SKIP (0.000s)
[135.249608] [113/162] (859s left) kms_frontbuffer_tracking (basic)
[135.307390] Starting subtest: basic
[138.366167] Subtest basic: SUCCESS (3.061s)
[138.518689] [114/162] (856s left) kms_hdmi_inject (inject-audio)
[138.569280] Subtest inject-audio: SKIP (0.000s)
[138.626122] [115/162] (856s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[138.680673] Starting subtest: compare-crc-sanitycheck-xr24
[138.682726] Starting dynamic subtest: pipe-A-eDP-1
[139.355798] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.673s)
[139.366045] Starting dynamic subtest: pipe-B-eDP-1
[140.742973] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.386s)
[140.757767] Starting dynamic subtest: pipe-C-eDP-1
[142.122365] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.377s)
[142.133134] Starting dynamic subtest: pipe-D-eDP-1
[143.411873] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.287s)
[143.413988] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.730s)
[144.266830] [116/162] (850s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[144.331052] Starting subtest: compare-crc-sanitycheck-nv12
[144.332861] Starting dynamic subtest: pipe-A-eDP-1
[145.073311] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.742s)
[145.084533] Starting dynamic subtest: pipe-B-eDP-1
[146.469332] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.394s)
[146.481604] Starting dynamic subtest: pipe-C-eDP-1
[147.829081] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.358s)
[147.845547] Starting dynamic subtest: pipe-D-eDP-1
[149.149457] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.319s)
[149.150880] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.821s)
[150.003513] [117/162] (845s left) kms_pipe_crc_basic (hang-read-crc)
[150.076085] Starting subtest: hang-read-crc
[150.077705] Starting dynamic subtest: pipe-A-eDP-1
[152.430045] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.351s)
[152.440805] Starting dynamic subtest: pipe-B-eDP-1
[155.281047] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.848s)
[155.293819] Starting dynamic subtest: pipe-C-eDP-1
[158.098281] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.816s)
[158.108366] Starting dynamic subtest: pipe-D-eDP-1
[160.885726] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.784s)
[160.887280] Subtest hang-read-crc: SUCCESS (10.809s)
[161.751209] [118/162] (833s left) kms_pipe_crc_basic (nonblocking-crc)
[161.815605] Starting subtest: nonblocking-crc
[161.817357] Starting dynamic subtest: pipe-A-eDP-1
[162.694054] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.879s)
[162.714836] Starting dynamic subtest: pipe-B-eDP-1
[164.212519] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.513s)
[164.231954] Starting dynamic subtest: pipe-C-eDP-1
[165.690671] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.477s)
[165.703536] Starting dynamic subtest: pipe-D-eDP-1
[167.204439] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.512s)
[167.206320] Subtest nonblocking-crc: SUCCESS (5.390s)
[168.095697] [119/162] (827s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[168.164423] Starting subtest: nonblocking-crc-frame-sequence
[168.167120] Starting dynamic subtest: pipe-A-eDP-1
[169.040789] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.876s)
[169.056593] Starting dynamic subtest: pipe-B-eDP-1
[170.545251] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.501s)
[170.564064] Starting dynamic subtest: pipe-C-eDP-1
[172.037428] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.489s)
[172.053743] Starting dynamic subtest: pipe-D-eDP-1
[173.554157] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.515s)
[173.555903] Subtest nonblocking-crc-frame-sequence: SUCCESS (5.390s)
[174.466623] [120/162] (820s left) kms_pipe_crc_basic (read-crc)
[174.542174] Starting subtest: read-crc
[174.544068] Starting dynamic subtest: pipe-A-eDP-1
[175.357522] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.808s)
[175.378426] Starting dynamic subtest: pipe-B-eDP-1
[176.845359] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.489s)
[176.864067] Starting dynamic subtest: pipe-C-eDP-1
[178.236981] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.388s)
[178.253032] Starting dynamic subtest: pipe-D-eDP-1
[179.618773] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.382s)
[179.620628] Subtest read-crc: SUCCESS (5.077s)
[180.520690] [121/162] (814s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[180.584745] Starting subtest: read-crc-frame-sequence
[180.586343] Starting dynamic subtest: pipe-A-eDP-1
[181.385837] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.802s)
[181.403216] Starting dynamic subtest: pipe-B-eDP-1
[182.877450] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.486s)
[182.890531] Starting dynamic subtest: pipe-C-eDP-1
[184.280483] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.403s)
[184.300729] Starting dynamic subtest: pipe-D-eDP-1
[185.658138] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.373s)
[185.660149] Subtest read-crc-frame-sequence: SUCCESS (5.075s)
[186.519030] [122/162] (808s left) kms_pm_backlight (basic-brightness)
[186.585666] Starting subtest: basic-brightness
[186.612974] Starting dynamic subtest: eDP-1
[186.952396] Dynamic subtest eDP-1: SUCCESS (0.338s)
[186.954117] Subtest basic-brightness: SUCCESS (0.366s)
[187.819486] [123/162] (807s left) kms_pm_rpm (basic-pci-d3-state)
[189.342294] Starting subtest: basic-pci-d3-state
[190.822651] Subtest basic-pci-d3-state: SUCCESS (1.480s)
[190.972627] [124/162] (804s left) kms_pm_rpm (basic-rte)
[191.019402] Starting subtest: basic-rte
[193.928766] Subtest basic-rte: SUCCESS (2.911s)
[195.451285] [125/162] (800s left) kms_psr (psr-primary-page-flip)
[195.510828] Subtest psr-primary-page-flip: SKIP (0.000s)
[195.578355] [126/162] (800s left) kms_psr (psr-cursor-plane-move)
[195.630999] Subtest psr-cursor-plane-move: SKIP (0.000s)
[195.680928] [127/162] (800s left) kms_psr (psr-sprite-plane-onoff)
[195.737882] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[195.805632] [128/162] (800s left) kms_psr (psr-primary-mmap-gtt)
[195.866117] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[195.916590] [129/162] (799s left) kms_setmode (basic-clone-single-crtc)
[195.957895] Starting subtest: basic-clone-single-crtc
[195.963231] Subtest basic-clone-single-crtc: SKIP (0.000s)
[196.047645] [130/162] (799s left) i915_pm_rps (basic-api)
[196.098449] Starting subtest: basic-api
[196.102939] Subtest basic-api: SKIP (0.001s)
[196.199821] [131/162] (799s left) prime_self_import (basic-llseek-bad)
[196.246910] Starting subtest: basic-llseek-bad
[196.251831] Subtest basic-llseek-bad: SUCCESS (0.002s)
[196.374137] [132/162] (799s left) prime_self_import (basic-llseek-size)
[196.417395] Starting subtest: basic-llseek-size
[196.420942] Subtest basic-llseek-size: SUCCESS (0.002s)
[196.534333] [133/162] (799s left) prime_self_import (basic-with_fd_dup)
[196.567017] Starting subtest: basic-with_fd_dup
[196.570257] Subtest basic-with_fd_dup: SUCCESS (0.003s)
[196.686278] [134/162] (799s left) prime_self_import (basic-with_one_bo)
[196.723716] Starting subtest: basic-with_one_bo
[196.728150] Subtest basic-with_one_bo: SUCCESS (0.004s)
[196.883631] [135/162] (799s left) prime_self_import (basic-with_one_bo_two_files)
[196.938949] Starting subtest: basic-with_one_bo_two_files
[196.943214] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s)
[197.065546] [136/162] (799s left) prime_self_import (basic-with_two_bos)
[197.105189] Starting subtest: basic-with_two_bos
[197.109100] Subtest basic-with_two_bos: SUCCESS (0.004s)
[197.232901] [137/162] (799s left) prime_vgem (basic-fence-flip)
[197.304093] Starting subtest: basic-fence-flip
[197.649793] Subtest basic-fence-flip: SUCCESS (0.342s)
[197.788099] [138/162] (798s left) prime_vgem (basic-fence-mmap)
[197.876263] Starting subtest: basic-fence-mmap
[197.901198] Subtest basic-fence-mmap: SUCCESS (0.026s)
[198.028683] [139/162] (798s left) prime_vgem (basic-fence-read)
[198.088363] Starting subtest: basic-fence-read
[198.104793] Subtest basic-fence-read: SKIP (0.004s)
[198.216544] [140/162] (798s left) prime_vgem (basic-gtt)
[198.286950] Starting subtest: basic-gtt
[198.301141] Subtest basic-gtt: SUCCESS (0.015s)
[198.443294] [141/162] (798s left) prime_vgem (basic-read)
[198.549534] Starting subtest: basic-read
[198.558927] Subtest basic-read: SKIP (0.008s)
[198.694628] [142/162] (797s left) prime_vgem (basic-write)
[198.778193] Starting subtest: basic-write
[198.785193] Subtest basic-write: SKIP (0.004s)
[198.929723] [143/162] (797s left) vgem_basic (setversion)
[198.981852] Starting subtest: setversion
[198.987220] Subtest setversion: SUCCESS (0.000s)
[199.073613] [144/162] (797s left) vgem_basic (create)
[199.133311] Starting subtest: create
[199.135381] Subtest create: SUCCESS (0.000s)
[199.249514] [145/162] (797s left) vgem_basic (debugfs)
[199.296877] Starting subtest: debugfs
[199.298833] Subtest debugfs: SUCCESS (0.000s)
[199.381823] [146/162] (797s left) vgem_basic (dmabuf-export)
[199.430934] Starting subtest: dmabuf-export
[199.454913] Subtest dmabuf-export: SUCCESS (0.022s)
[199.566593] [147/162] (797s left) vgem_basic (dmabuf-fence)
[199.613770] Starting subtest: dmabuf-fence
[199.615974] Subtest dmabuf-fence: SUCCESS (0.001s)
[199.720475] [148/162] (797s left) vgem_basic (dmabuf-fence-before)
[199.787167] Starting subtest: dmabuf-fence-before
[199.790221] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[199.861151] [149/162] (796s left) vgem_basic (dmabuf-mmap)
[199.915038] Starting subtest: dmabuf-mmap
[199.925899] Subtest dmabuf-mmap: SUCCESS (0.013s)
[200.020259] [150/162] (796s left) vgem_basic (mmap)
[200.085996] Starting subtest: mmap
[200.088017] Subtest mmap: SUCCESS (0.008s)
[200.164335] [151/162] (796s left) vgem_basic (second-client)
[200.214733] Starting subtest: second-client
[200.254163] Subtest second-client: SUCCESS (0.034s)
[200.333401] [152/162] (796s left) vgem_basic (sysfs)
[200.400113] Starting subtest: sysfs
[200.413969] Subtest sysfs: SUCCESS (0.001s)
[200.483902] [153/162] (796s left) core_hotunplug (unbind-rebind)
[200.580178] Starting subtest: unbind-rebind
[206.512197] Subtest unbind-rebind: SUCCESS (5.932s)
[206.551754] [154/162] (790s left) vgem_basic (unload)
[206.599319] Starting subtest: unload
[235.658336] Subtest unload: SUCCESS (29.019s)
[235.750792] [155/162] (761s left) i915_module_load (reload)
[235.803983] Starting subtest: reload
[240.818614] Subtest reload: SUCCESS (5.019s)
[240.855839] [156/162] (756s left) gem_lmem_swapping (basic)
[240.901268] Subtest basic: SKIP (0.000s)
[240.970303] [157/162] (756s left) gem_lmem_swapping (parallel-random-engines)
[241.020925] Subtest parallel-random-engines: SKIP (0.000s)
[241.075499] [158/162] (756s left) gem_lmem_swapping (random-engines)
[241.126974] Subtest random-engines: SKIP (0.000s)
[241.182650] [159/162] (756s left) gem_lmem_swapping (verify-random)
[241.235993] Subtest verify-random: SKIP (0.000s)
[241.304732] [160/162] (756s left) i915_pm_rpm (module-reload)
[243.537132] Starting subtest: module-reload
[258.251267] Subtest module-reload: SUCCESS (14.711s)
[258.299378] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[258.300320] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true
[258.303377] [161/162] (739s left) i915_selftest (live)