[39.608267] Initializing watchdogs
[39.608384]   /dev/watchdog0
[39.650438] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[39.657653] [001/162] (960s left) i915_module_load (load)
[39.758245] Starting subtest: load
[42.044560] Subtest load: SUCCESS (2.286s)
[42.116941] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[42.122043] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[42.127076] [002/162] (958s left) core_auth (basic-auth)
[42.276850] Starting subtest: basic-auth
[42.304917] Subtest basic-auth: SUCCESS (0.028s)
[42.443469] [003/162] (957s left) core_debugfs (read-all-entries)
[42.553183] Starting subtest: read-all-entries
[42.648507] Subtest read-all-entries: SUCCESS (0.094s)
[42.921149] [004/162] (957s left) core_sysfs (read-all-entries)
[43.031715] Starting subtest: read-all-entries
[43.040576] Subtest read-all-entries: SUCCESS (0.010s)
[43.216158] [005/162] (957s left) fbdev (eof)
[43.312217] Starting subtest: eof
[43.313902] Subtest eof: SUCCESS (0.001s)
[43.486168] [006/162] (957s left) fbdev (info)
[43.569477] Starting subtest: info
[43.571186] Subtest info: SUCCESS (0.000s)
[43.712187] [007/162] (957s left) fbdev (nullptr)
[43.813736] Starting subtest: nullptr
[43.817752] Subtest nullptr: SUCCESS (0.000s)
[43.975214] [008/162] (956s left) fbdev (read)
[44.061105] Starting subtest: read
[45.561705] Subtest read: SUCCESS (1.497s)
[45.702945] [009/162] (955s left) fbdev (write)
[45.822256] Starting subtest: write
[46.587711] Subtest write: SUCCESS (0.770s)
[46.713073] [010/162] (954s left) gem_basic (bad-close)
[46.819786] Starting subtest: bad-close
[46.823998] Subtest bad-close: SUCCESS (0.000s)
[46.981945] [011/162] (954s left) gem_basic (create-close)
[47.085847] Starting subtest: create-close
[47.091764] Subtest create-close: SUCCESS (0.000s)
[47.289393] [012/162] (953s left) gem_basic (create-fd-close)
[47.399959] Starting subtest: create-fd-close
[47.402873] Subtest create-fd-close: SUCCESS (0.002s)
[47.615484] [013/162] (953s left) gem_busy (busy@all-engines)
[47.754244] Starting subtest: busy
[47.755870] Starting dynamic subtest: all-engines
[47.930716] Dynamic subtest all-engines: SUCCESS (0.176s)
[47.932421] Subtest busy: SUCCESS (0.177s)
[48.524104] [014/162] (952s left) gem_close_race (basic-process)
[48.681570] Starting subtest: basic-process
[48.768387] Subtest basic-process: SUCCESS (0.087s)
[49.111211] [015/162] (952s left) gem_close_race (basic-threads)
[49.272118] Starting subtest: basic-threads
[50.588295] Subtest basic-threads: SUCCESS (1.315s)
[50.971231] [016/162] (950s left) gem_ctx_create (basic)
[51.097681] Starting subtest: basic
[51.099564] Subtest basic: SUCCESS (0.000s)
[51.443042] [017/162] (950s left) gem_ctx_create (basic-files)
[51.571853] Starting subtest: basic-files
[53.594038] Subtest basic-files: SUCCESS (2.022s)
[54.125915] [018/162] (947s left) gem_ctx_exec (basic)
[54.233948] Starting subtest: basic
[54.250153] Subtest basic: SUCCESS (0.016s)
[54.479994] [019/162] (947s left) gem_exec_basic (basic)
[54.608027] Starting subtest: basic
[54.609821] Starting dynamic subtest: rcs0-smem
[54.620793] Dynamic subtest rcs0-smem: SUCCESS (0.006s)
[54.642297] Starting dynamic subtest: bcs0-smem
[54.645227] Dynamic subtest bcs0-smem: SUCCESS (0.008s)
[54.661658] Starting dynamic subtest: vcs0-smem
[54.663505] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[54.678555] Starting dynamic subtest: vcs1-smem
[54.680433] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[54.695793] Starting dynamic subtest: vecs0-smem
[54.697692] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[54.713121] Starting dynamic subtest: rcs0-lmem0
[54.714966] Dynamic subtest rcs0-lmem0: SUCCESS (0.002s)
[54.730212] Starting dynamic subtest: bcs0-lmem0
[54.732164] Dynamic subtest bcs0-lmem0: SUCCESS (0.000s)
[54.748458] Starting dynamic subtest: vcs0-lmem0
[54.750215] Dynamic subtest vcs0-lmem0: SUCCESS (0.000s)
[54.766231] Starting dynamic subtest: vcs1-lmem0
[54.768823] Dynamic subtest vcs1-lmem0: SUCCESS (0.000s)
[54.785023] Starting dynamic subtest: vecs0-lmem0
[54.787191] Dynamic subtest vecs0-lmem0: SUCCESS (0.000s)
[54.789166] Subtest basic: SUCCESS (0.031s)
[54.914007] [020/162] (947s left) gem_exec_create (basic)
[55.052244] Starting subtest: basic
[55.054180] Starting dynamic subtest: smem
[57.154104] Dynamic subtest smem: SUCCESS (2.102s)
[57.172229] Starting dynamic subtest: lmem0
[59.266962] Dynamic subtest lmem0: SUCCESS (2.119s)
[59.268549] Subtest basic: SUCCESS (4.221s)
[59.598334] [021/162] (942s left) gem_exec_fence (basic-busy)
[59.897138] Starting subtest: basic-busy
[59.898919] Starting dynamic subtest: rcs0
[59.997158] Dynamic subtest rcs0: SUCCESS (0.100s)
[60.043339] Starting dynamic subtest: bcs0
[60.053510] Dynamic subtest bcs0: SUCCESS (0.056s)
[60.072762] Starting dynamic subtest: vcs0
[60.104511] Dynamic subtest vcs0: SUCCESS (0.050s)
[60.122692] Starting dynamic subtest: vcs1
[60.159855] Dynamic subtest vcs1: SUCCESS (0.055s)
[60.191904] Starting dynamic subtest: vecs0
[60.211706] Dynamic subtest vecs0: SUCCESS (0.051s)
[60.213546] Subtest basic-busy: SUCCESS (0.316s)
[61.140983] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[61.144220] [022/162] (941s left) gem_exec_fence (basic-wait)
[61.458993] Starting subtest: basic-wait
[61.461173] Starting dynamic subtest: rcs0
[61.569287] Dynamic subtest rcs0: SUCCESS (0.109s)
[61.623217] Starting dynamic subtest: bcs0
[61.636396] Dynamic subtest bcs0: SUCCESS (0.064s)
[61.654916] Starting dynamic subtest: vcs0
[61.688759] Dynamic subtest vcs0: SUCCESS (0.055s)
[61.706247] Starting dynamic subtest: vcs1
[61.737809] Dynamic subtest vcs1: SUCCESS (0.049s)
[61.760814] Starting dynamic subtest: vecs0
[61.795042] Dynamic subtest vecs0: SUCCESS (0.057s)
[61.797385] Subtest basic-wait: SUCCESS (0.338s)
[62.531159] [023/162] (939s left) gem_exec_fence (basic-await)
[62.799100] Starting subtest: basic-await
[62.803364] Starting dynamic subtest: rcs0
[62.934777] Dynamic subtest rcs0: SUCCESS (0.138s)
[62.951960] Starting dynamic subtest: bcs0
[63.045722] Dynamic subtest bcs0: SUCCESS (0.111s)
[63.063122] Starting dynamic subtest: vcs0
[63.162020] Dynamic subtest vcs0: SUCCESS (0.116s)
[63.182679] Starting dynamic subtest: vcs1
[63.273245] Dynamic subtest vcs1: SUCCESS (0.112s)
[63.290447] Starting dynamic subtest: vecs0
[63.379029] Dynamic subtest vecs0: SUCCESS (0.105s)
[63.380787] Subtest basic-await: SUCCESS (0.584s)
[64.168773] [024/162] (938s left) gem_exec_fence (nb-await)
[64.490444] Starting subtest: nb-await
[64.492372] Starting dynamic subtest: rcs0
[64.609963] Dynamic subtest rcs0: SUCCESS (0.116s)
[64.628945] Starting dynamic subtest: bcs0
[64.684050] Dynamic subtest bcs0: SUCCESS (0.077s)
[64.722607] Starting dynamic subtest: vcs0
[64.778744] Dynamic subtest vcs0: SUCCESS (0.094s)
[64.829620] Starting dynamic subtest: vcs1
[64.879858] Dynamic subtest vcs1: SUCCESS (0.101s)
[64.910319] Starting dynamic subtest: vecs0
[64.975361] Dynamic subtest vecs0: SUCCESS (0.089s)
[64.990353] Subtest nb-await: SUCCESS (0.498s)
[65.779968] [025/162] (936s left) gem_exec_gttfill (basic)
[65.924439] Starting subtest: basic
[78.078553] Subtest basic: SUCCESS (12.165s)
[78.379063] [026/162] (924s left) gem_exec_parallel (engines)
[78.574620] Starting subtest: engines
[78.578234] Starting dynamic subtest: basic
[81.183222] Dynamic subtest basic: SUCCESS (2.610s)
[81.201369] Starting dynamic subtest: contexts
[86.205388] Dynamic subtest contexts: SUCCESS (5.021s)
[86.225632] Starting dynamic subtest: fds
[92.265195] Dynamic subtest fds: SUCCESS (6.061s)
[92.283434] Starting dynamic subtest: userptr
[95.241150] Dynamic subtest userptr: SUCCESS (2.980s)
[95.242947] Subtest engines: SUCCESS (16.675s)
[95.607219] [027/162] (907s left) gem_exec_store (basic)
[95.755861] Starting subtest: basic
[95.874199] Subtest basic: SUCCESS (0.120s)
[96.256908] [028/162] (906s left) gem_flink_basic (bad-flink)
[96.377817] Starting subtest: bad-flink
[96.379717] Subtest bad-flink: SUCCESS (0.000s)
[96.532151] [029/162] (906s left) gem_flink_basic (bad-open)
[96.653163] Starting subtest: bad-open
[96.654804] Subtest bad-open: SUCCESS (0.000s)
[96.833541] [030/162] (906s left) gem_flink_basic (basic)
[96.950164] Starting subtest: basic
[96.951840] Subtest basic: SUCCESS (0.000s)
[97.155649] [031/162] (906s left) gem_flink_basic (double-flink)
[97.277610] Starting subtest: double-flink
[97.279550] Subtest double-flink: SUCCESS (0.000s)
[97.462559] [032/162] (906s left) gem_flink_basic (flink-lifetime)
[97.585206] Starting subtest: flink-lifetime
[97.644194] Subtest flink-lifetime: SUCCESS (0.061s)
[97.899304] [033/162] (905s left) gem_huc_copy (huc-copy)
[98.050495] Starting subtest: huc-copy
[98.060630] Subtest huc-copy: SUCCESS (0.009s)
[98.301863] [034/162] (905s left) gem_linear_blits (basic)
[98.655179] Starting subtest: basic
[98.692256] Subtest basic: SUCCESS (0.037s)
[98.953098] [035/162] (904s left) gem_mmap (basic)
[99.141858] Subtest basic: SKIP (0.000s)
[99.253274] [036/162] (904s left) gem_mmap_gtt (basic)
[99.382638] Subtest basic: SKIP (0.000s)
[99.491192] [037/162] (904s left) gem_render_linear_blits (basic)
[99.624706] Starting subtest: basic
[99.724443] Subtest basic: SUCCESS (0.100s)
[99.873216] [038/162] (904s left) gem_render_tiled_blits (basic)
[100.011037] Subtest basic: SKIP (0.000s)
[100.119888] [039/162] (904s left) gem_ringfill (basic-all)
[100.664754] Starting subtest: basic-all
[101.975137] Subtest basic-all: SUCCESS (1.298s)
[102.231296] [040/162] (902s left) gem_softpin (allocator-basic)
[102.370145] Starting subtest: allocator-basic
[102.822995] Subtest allocator-basic: SUCCESS (0.458s)
[103.096778] [041/162] (901s left) gem_softpin (allocator-basic-reserve)
[103.225915] Starting subtest: allocator-basic-reserve
[103.623315] Subtest allocator-basic-reserve: SUCCESS (0.394s)
[103.842117] [042/162] (900s left) gem_softpin (safe-alignment)
[103.974214] Starting subtest: safe-alignment
[104.034776] Subtest safe-alignment: SUCCESS (0.059s)
[104.281117] [043/162] (900s left) gem_sync (basic-all)
[104.425530] Starting subtest: basic-all
[106.998844] Subtest basic-all: SUCCESS (2.576s)
[107.342127] [044/162] (897s left) gem_sync (basic-each)
[107.483715] Starting subtest: basic-each
[109.698131] Subtest basic-each: SUCCESS (2.215s)
[110.061847] [045/162] (894s left) gem_tiled_blits (basic)
[110.192727] Subtest basic: SKIP (0.000s)
[110.303404] [046/162] (894s left) gem_tiled_fence_blits (basic)
[110.432779] Subtest basic: SKIP (0.000s)
[110.535179] [047/162] (894s left) gem_tiled_pread_basic
[110.766266] [048/162] (894s left) gem_wait (busy@all-engines)
[110.913177] Starting subtest: busy
[110.914867] Starting dynamic subtest: all-engines
[111.486311] Dynamic subtest all-engines: SUCCESS (0.573s)
[111.487962] Subtest busy: SUCCESS (0.573s)
[111.812810] [049/162] (893s left) gem_wait (wait@all-engines)
[111.959760] Starting subtest: wait
[111.961499] Starting dynamic subtest: all-engines
[113.060940] Dynamic subtest all-engines: SUCCESS (1.101s)
[113.062808] Subtest wait: SUCCESS (1.102s)
[113.522042] [050/162] (892s left) i915_getparams_basic (basic-eu-total)
[113.642146] Starting subtest: basic-eu-total
[113.645689] Subtest basic-eu-total: SUCCESS (0.000s)
[113.803893] [051/162] (891s left) i915_getparams_basic (basic-subslice-total)
[113.925204] Starting subtest: basic-subslice-total
[113.930659] Subtest basic-subslice-total: SUCCESS (0.000s)
[114.092275] [052/162] (891s left) i915_hangman (error-state-basic)
[114.264399] Starting subtest: error-state-basic
[114.429753] Subtest error-state-basic: SUCCESS (0.164s)
[114.634229] [053/162] (891s left) i915_pciid
[114.965856] [054/162] (891s left) intel_hwmon (hwmon-read)
[115.083652] Starting subtest: hwmon-read
[115.093206] Subtest hwmon-read: SUCCESS (0.010s)
[115.289515] [055/162] (890s left) intel_hwmon (hwmon-write)
[115.408862] Starting subtest: hwmon-write
[115.450182] Subtest hwmon-write: SUCCESS (0.042s)
[115.610728] [056/162] (890s left) kms_addfb_basic (addfb25-4-tiled)
[115.839250] Starting subtest: addfb25-4-tiled
[115.840695] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[116.024499] [057/162] (890s left) kms_addfb_basic (addfb25-bad-modifier)
[116.248323] Starting subtest: addfb25-bad-modifier
[116.249788] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[116.457574] [058/162] (890s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[116.686107] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[116.874986] [059/162] (889s left) kms_addfb_basic (addfb25-modifier-no-flag)
[117.096926] Starting subtest: addfb25-modifier-no-flag
[117.098796] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[117.309200] [060/162] (889s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[117.531038] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[117.762832] [061/162] (889s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[117.989649] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[118.180432] [062/162] (888s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[118.406577] Starting subtest: addfb25-yf-tiled-legacy
[118.408409] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[118.595853] [063/162] (888s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[118.817470] Starting subtest: addfb25-y-tiled-legacy
[118.818951] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[119.013093] [064/162] (888s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[119.234151] Starting subtest: addfb25-y-tiled-small-legacy
[119.235821] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s)
[119.430755] [065/162] (887s left) kms_addfb_basic (bad-pitch-0)
[119.555963] Starting subtest: bad-pitch-0
[119.558481] Subtest bad-pitch-0: SUCCESS (0.000s)
[119.842722] [066/162] (887s left) kms_addfb_basic (bad-pitch-1024)
[119.961198] Starting subtest: bad-pitch-1024
[119.963174] Subtest bad-pitch-1024: SUCCESS (0.000s)
[120.263705] [067/162] (887s left) kms_addfb_basic (bad-pitch-128)
[120.383784] Starting subtest: bad-pitch-128
[120.386024] Subtest bad-pitch-128: SUCCESS (0.000s)
[120.684919] [068/162] (886s left) kms_addfb_basic (bad-pitch-256)
[120.804954] Starting subtest: bad-pitch-256
[120.807816] Subtest bad-pitch-256: SUCCESS (0.000s)
[121.128472] [069/162] (886s left) kms_addfb_basic (bad-pitch-32)
[121.245512] Starting subtest: bad-pitch-32
[121.246984] Subtest bad-pitch-32: SUCCESS (0.000s)
[121.528475] [070/162] (886s left) kms_addfb_basic (bad-pitch-63)
[121.647953] Starting subtest: bad-pitch-63
[121.649590] Subtest bad-pitch-63: SUCCESS (0.000s)
[121.990493] [071/162] (886s left) kms_addfb_basic (bad-pitch-65536)
[122.114860] Starting subtest: bad-pitch-65536
[122.116890] Subtest bad-pitch-65536: SUCCESS (0.000s)
[122.414712] [072/162] (885s left) kms_addfb_basic (bad-pitch-999)
[122.534710] Starting subtest: bad-pitch-999
[122.537112] Subtest bad-pitch-999: SUCCESS (0.000s)
[122.825030] [073/162] (885s left) kms_addfb_basic (basic)
[122.941863] Starting subtest: basic
[122.943583] Subtest basic: SUCCESS (0.000s)
[123.254432] [074/162] (885s left) kms_addfb_basic (basic-x-tiled-legacy)
[123.377758] Starting subtest: basic-x-tiled-legacy
[123.382758] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[123.681211] [075/162] (884s left) kms_addfb_basic (basic-y-tiled-legacy)
[123.800945] Starting subtest: basic-y-tiled-legacy
[123.805347] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[124.128949] [076/162] (884s left) kms_addfb_basic (bo-too-small)
[124.364369] Starting subtest: bo-too-small
[124.365943] Subtest bo-too-small: SUCCESS (0.000s)
[124.598820] [077/162] (884s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[124.817778] Starting subtest: bo-too-small-due-to-tiling
[124.821587] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[125.048650] [078/162] (883s left) kms_addfb_basic (clobberred-modifier)
[125.166950] Starting subtest: clobberred-modifier
[125.170783] Subtest clobberred-modifier: SKIP (0.000s)
[125.467517] [079/162] (883s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[125.589690] Starting subtest: framebuffer-vs-set-tiling
[125.592851] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[125.896817] [080/162] (883s left) kms_addfb_basic (invalid-get-prop)
[126.020926] Starting subtest: invalid-get-prop
[126.023912] Subtest invalid-get-prop: SUCCESS (0.000s)
[126.306753] [081/162] (882s left) kms_addfb_basic (invalid-get-prop-any)
[126.431037] Starting subtest: invalid-get-prop-any
[126.434605] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[126.730536] [082/162] (882s left) kms_addfb_basic (invalid-set-prop)
[126.852994] Starting subtest: invalid-set-prop
[126.855993] Subtest invalid-set-prop: SUCCESS (0.000s)
[127.146186] [083/162] (882s left) kms_addfb_basic (invalid-set-prop-any)
[127.266177] Starting subtest: invalid-set-prop-any
[127.268035] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[127.591232] [084/162] (881s left) kms_addfb_basic (no-handle)
[127.713180] Starting subtest: no-handle
[127.715149] Subtest no-handle: SUCCESS (0.000s)
[128.049903] [085/162] (881s left) kms_addfb_basic (size-max)
[128.272523] Starting subtest: size-max
[128.273949] Subtest size-max: SUCCESS (0.000s)
[128.441113] [086/162] (881s left) kms_addfb_basic (small-bo)
[128.662105] Starting subtest: small-bo
[128.663716] Subtest small-bo: SUCCESS (0.000s)
[128.842731] [087/162] (881s left) kms_addfb_basic (tile-pitch-mismatch)
[128.963523] Starting subtest: tile-pitch-mismatch
[128.967782] Subtest tile-pitch-mismatch: SKIP (0.000s)
[129.269178] [088/162] (880s left) kms_addfb_basic (too-high)
[129.491409] Starting subtest: too-high
[129.492835] Subtest too-high: SUCCESS (0.001s)
[129.696721] [089/162] (880s left) kms_addfb_basic (too-wide)
[129.916145] Starting subtest: too-wide
[129.917699] Subtest too-wide: SUCCESS (0.000s)
[130.132292] [090/162] (880s left) kms_addfb_basic (unused-handle)
[130.252751] Starting subtest: unused-handle
[130.254924] Subtest unused-handle: SUCCESS (0.000s)
[130.545140] [091/162] (879s left) kms_addfb_basic (unused-modifier)
[130.666769] Starting subtest: unused-modifier
[130.669022] Subtest unused-modifier: SUCCESS (0.000s)
[130.962978] [092/162] (879s left) kms_addfb_basic (unused-offsets)
[131.090726] Starting subtest: unused-offsets
[131.093752] Subtest unused-offsets: SUCCESS (0.000s)
[131.379429] [093/162] (879s left) kms_addfb_basic (unused-pitches)
[131.498394] Starting subtest: unused-pitches
[131.500116] Subtest unused-pitches: SUCCESS (0.000s)
[131.797164] [094/162] (878s left) kms_busy (basic)
[132.024372] Starting subtest: basic
[132.027760] Starting dynamic subtest: flip
[133.093304] Dynamic subtest flip: SUCCESS (1.067s)
[133.122471] Starting dynamic subtest: modeset
[133.973242] Dynamic subtest modeset: SUCCESS (0.877s)
[133.974928] Subtest basic: SUCCESS (1.946s)
[134.285930] [095/162] (876s left) kms_prop_blob (basic)
[134.408764] Starting subtest: basic
[134.410400] Subtest basic: SUCCESS (0.000s)
[134.564660] [096/162] (876s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[134.781390] Starting subtest: basic-busy-flip-before-cursor-atomic
[134.784747] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[134.930033] [097/162] (876s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[135.150583] Starting subtest: basic-busy-flip-before-cursor-legacy
[135.154120] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[135.317542] [098/162] (875s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[135.537119] Starting subtest: basic-flip-after-cursor-atomic
[136.617535] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.073s)
[136.859829] [099/162] (874s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[137.082579] Starting subtest: basic-flip-after-cursor-legacy
[138.154364] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.071s)
[138.418227] [100/162] (872s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[138.635207] Starting subtest: basic-flip-after-cursor-varying-size
[139.677658] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.043s)
[139.951984] [101/162] (871s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[140.171099] Starting subtest: basic-flip-before-cursor-atomic
[141.229693] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.060s)
[141.490564] [102/162] (870s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[141.712660] Starting subtest: basic-flip-before-cursor-legacy
[142.798184] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.083s)
[143.094209] [103/162] (868s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[143.314576] Starting subtest: basic-flip-before-cursor-varying-size
[144.404967] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.090s)
[144.681884] [104/162] (867s left) kms_dsc (dsc-basic)
[144.904887] Starting subtest: dsc-basic
[144.924786] Subtest dsc-basic: SKIP (0.001s)
[145.070921] [105/162] (866s left) kms_flip (basic-flip-vs-dpms)
[145.293981] Starting subtest: basic-flip-vs-dpms
[145.299534] Starting dynamic subtest: A-HDMI-A2
[146.137759] Dynamic subtest A-HDMI-A2: SUCCESS (0.838s)
[146.158759] Starting dynamic subtest: B-HDMI-A2
[146.943952] Dynamic subtest B-HDMI-A2: SUCCESS (0.805s)
[146.969671] Starting dynamic subtest: C-HDMI-A2
[147.759058] Dynamic subtest C-HDMI-A2: SUCCESS (0.812s)
[147.779932] Starting dynamic subtest: D-HDMI-A2
[148.604848] Dynamic subtest D-HDMI-A2: SUCCESS (0.846s)
[148.608561] Subtest basic-flip-vs-dpms: SUCCESS (3.317s)
[148.878789] [106/162] (863s left) kms_flip (basic-flip-vs-modeset)
[149.107511] Starting subtest: basic-flip-vs-modeset
[149.114271] Starting dynamic subtest: A-HDMI-A2
[149.977509] Dynamic subtest A-HDMI-A2: SUCCESS (0.862s)
[149.997634] Starting dynamic subtest: B-HDMI-A2
[150.666449] Dynamic subtest B-HDMI-A2: SUCCESS (0.688s)
[150.687148] Starting dynamic subtest: C-HDMI-A2
[151.367481] Dynamic subtest C-HDMI-A2: SUCCESS (0.699s)
[151.387879] Starting dynamic subtest: D-HDMI-A2
[152.082729] Dynamic subtest D-HDMI-A2: SUCCESS (0.713s)
[152.084461] Subtest basic-flip-vs-modeset: SUCCESS (2.978s)
[152.363372] [107/162] (859s left) kms_flip (basic-flip-vs-wf_vblank)
[152.583624] Starting subtest: basic-flip-vs-wf_vblank
[152.591785] Starting dynamic subtest: A-HDMI-A2
[153.695620] Dynamic subtest A-HDMI-A2: SUCCESS (1.104s)
[153.721696] Starting dynamic subtest: B-HDMI-A2
[154.735659] Dynamic subtest B-HDMI-A2: SUCCESS (1.037s)
[154.757430] Starting dynamic subtest: C-HDMI-A2
[155.942106] Dynamic subtest C-HDMI-A2: SUCCESS (1.204s)
[155.963641] Starting dynamic subtest: D-HDMI-A2
[156.984357] Dynamic subtest D-HDMI-A2: SUCCESS (1.041s)
[156.988542] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.406s)
[157.370307] [108/162] (854s left) kms_flip (basic-plain-flip)
[157.589503] Starting subtest: basic-plain-flip
[157.596548] Starting dynamic subtest: A-HDMI-A2
[158.433811] Dynamic subtest A-HDMI-A2: SUCCESS (0.837s)
[158.480966] Starting dynamic subtest: B-HDMI-A2
[159.241346] Dynamic subtest B-HDMI-A2: SUCCESS (0.801s)
[159.284909] Starting dynamic subtest: C-HDMI-A2
[160.012907] Dynamic subtest C-HDMI-A2: SUCCESS (0.765s)
[160.036451] Starting dynamic subtest: D-HDMI-A2
[160.771636] Dynamic subtest D-HDMI-A2: SUCCESS (0.757s)
[160.776245] Subtest basic-plain-flip: SUCCESS (3.188s)
[161.114391] [109/162] (851s left) kms_force_connector_basic (force-connector-state)
[161.332866] Starting subtest: force-connector-state
[161.669137] Subtest force-connector-state: SUCCESS (0.338s)
[162.186338] [110/162] (850s left) kms_force_connector_basic (force-edid)
[162.397189] Starting subtest: force-edid
[162.421162] Subtest force-edid: SUCCESS (0.027s)
[162.820778] [111/162] (849s left) kms_force_connector_basic (force-load-detect)
[163.027647] Starting subtest: force-load-detect
[163.030591] Subtest force-load-detect: SKIP (0.000s)
[163.352990] [112/162] (849s left) kms_force_connector_basic (prune-stale-modes)
[163.559132] Starting subtest: prune-stale-modes
[163.587499] Subtest prune-stale-modes: SUCCESS (0.030s)
[163.989790] [113/162] (848s left) kms_frontbuffer_tracking (basic)
[164.224833] Starting subtest: basic
[167.461374] Subtest basic: SUCCESS (3.237s)
[167.728993] [114/162] (845s left) kms_hdmi_inject (inject-audio)
[167.932439] Starting subtest: inject-audio
[168.060796] Subtest inject-audio: SUCCESS (0.128s)
[168.381868] [115/162] (844s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[168.601945] Starting subtest: compare-crc-sanitycheck-xr24
[168.603735] Starting dynamic subtest: pipe-A-HDMI-A-2
[169.177805] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.573s)
[169.199053] Starting dynamic subtest: pipe-B-HDMI-A-2
[169.699899] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.519s)
[169.722536] Starting dynamic subtest: pipe-C-HDMI-A-2
[170.225240] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.523s)
[170.248828] Starting dynamic subtest: pipe-D-HDMI-A-2
[170.750819] Dynamic subtest pipe-D-HDMI-A-2: SUCCESS (0.522s)
[170.752334] Subtest compare-crc-sanitycheck-xr24: SUCCESS (2.150s)
[171.005194] [116/162] (841s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[171.228168] Starting subtest: compare-crc-sanitycheck-nv12
[171.230415] Starting dynamic subtest: pipe-A-HDMI-A-2
[171.930146] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.701s)
[171.954126] Starting dynamic subtest: pipe-B-HDMI-A-2
[172.580497] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.648s)
[172.603749] Starting dynamic subtest: pipe-C-HDMI-A-2
[173.238083] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.654s)
[173.265450] Starting dynamic subtest: pipe-D-HDMI-A-2
[173.887086] Dynamic subtest pipe-D-HDMI-A-2: SUCCESS (0.643s)
[173.888961] Subtest compare-crc-sanitycheck-nv12: SUCCESS (2.659s)
[174.151683] [117/162] (838s left) kms_pipe_crc_basic (hang-read-crc)
[174.373672] Starting subtest: hang-read-crc
[174.375244] Starting dynamic subtest: pipe-A-HDMI-A-2
[176.131925] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (1.752s)
[176.153086] Starting dynamic subtest: pipe-B-HDMI-A-2
[177.653101] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (1.518s)
[177.688605] Starting dynamic subtest: pipe-C-HDMI-A-2
[179.231749] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.578s)
[179.254819] Starting dynamic subtest: pipe-D-HDMI-A-2
[180.754127] Dynamic subtest pipe-D-HDMI-A-2: SUCCESS (1.518s)
[180.756181] Subtest hang-read-crc: SUCCESS (6.381s)
[181.007714] [118/162] (832s left) kms_pipe_crc_basic (nonblocking-crc)
[181.227469] Starting subtest: nonblocking-crc
[181.229277] Starting dynamic subtest: pipe-A-HDMI-A-2
[182.012551] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.784s)
[182.034976] Starting dynamic subtest: pipe-B-HDMI-A-2
[182.695855] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.681s)
[182.720894] Starting dynamic subtest: pipe-C-HDMI-A-2
[183.412977] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.711s)
[183.433931] Starting dynamic subtest: pipe-D-HDMI-A-2
[184.054041] Dynamic subtest pipe-D-HDMI-A-2: SUCCESS (0.639s)
[184.055613] Subtest nonblocking-crc: SUCCESS (2.828s)
[184.303413] [119/162] (828s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[184.526113] Starting subtest: nonblocking-crc-frame-sequence
[184.527881] Starting dynamic subtest: pipe-A-HDMI-A-2
[185.327293] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.800s)
[185.351545] Starting dynamic subtest: pipe-B-HDMI-A-2
[186.002125] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.669s)
[186.027618] Starting dynamic subtest: pipe-C-HDMI-A-2
[186.690420] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.686s)
[186.714270] Starting dynamic subtest: pipe-D-HDMI-A-2
[187.377664] Dynamic subtest pipe-D-HDMI-A-2: SUCCESS (0.682s)
[187.379336] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.852s)
[187.627802] [120/162] (825s left) kms_pipe_crc_basic (read-crc)
[187.848177] Starting subtest: read-crc
[187.849943] Starting dynamic subtest: pipe-A-HDMI-A-2
[188.551376] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.699s)
[188.572013] Starting dynamic subtest: pipe-B-HDMI-A-2
[189.116953] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.564s)
[189.138157] Starting dynamic subtest: pipe-C-HDMI-A-2
[189.743518] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.623s)
[189.767213] Starting dynamic subtest: pipe-D-HDMI-A-2
[190.359076] Dynamic subtest pipe-D-HDMI-A-2: SUCCESS (0.613s)
[190.362580] Subtest read-crc: SUCCESS (2.511s)
[190.612915] [121/162] (822s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[190.833964] Starting subtest: read-crc-frame-sequence
[190.835717] Starting dynamic subtest: pipe-A-HDMI-A-2
[191.537675] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.701s)
[191.560457] Starting dynamic subtest: pipe-B-HDMI-A-2
[192.154522] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.615s)
[192.178552] Starting dynamic subtest: pipe-C-HDMI-A-2
[192.729297] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.572s)
[192.752980] Starting dynamic subtest: pipe-D-HDMI-A-2
[193.309270] Dynamic subtest pipe-D-HDMI-A-2: SUCCESS (0.575s)
[193.310788] Subtest read-crc-frame-sequence: SUCCESS (2.476s)
[193.557555] [122/162] (820s left) kms_pm_backlight (basic-brightness)
[193.781616] Subtest basic-brightness: SKIP (0.000s)
[193.885766] [123/162] (819s left) kms_pm_rpm (basic-pci-d3-state)
[196.131636] Starting subtest: basic-pci-d3-state
[196.575920] Subtest basic-pci-d3-state: SUCCESS (0.443s)
[196.814689] [124/162] (816s left) kms_pm_rpm (basic-rte)
[196.905111] Starting subtest: basic-rte
[199.460487] Subtest basic-rte: SUCCESS (2.556s)
[200.072095] [125/162] (813s left) kms_psr (psr-primary-page-flip)
[200.290634] Subtest psr-primary-page-flip: SKIP (0.000s)
[200.406204] [126/162] (813s left) kms_psr (psr-cursor-plane-move)
[200.643523] Subtest psr-cursor-plane-move: SKIP (0.000s)
[200.751756] [127/162] (813s left) kms_psr (psr-sprite-plane-onoff)
[200.969315] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[201.084203] [128/162] (813s left) kms_psr (psr-primary-mmap-gtt)
[201.303728] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[201.417809] [129/162] (812s left) kms_setmode (basic-clone-single-crtc)
[201.543209] Starting subtest: basic-clone-single-crtc
[201.548242] Subtest basic-clone-single-crtc: SKIP (0.001s)
[201.761429] [130/162] (812s left) i915_pm_rps (basic-api)
[201.900288] Starting subtest: basic-api
[201.906180] Subtest basic-api: SKIP (0.002s)
[202.100391] [131/162] (812s left) prime_self_import (basic-llseek-bad)
[202.195197] Starting subtest: basic-llseek-bad
[202.225770] Subtest basic-llseek-bad: SUCCESS (0.032s)
[202.452182] [132/162] (812s left) prime_self_import (basic-llseek-size)
[202.543130] Starting subtest: basic-llseek-size
[202.579190] Subtest basic-llseek-size: SUCCESS (0.035s)
[202.785893] [133/162] (812s left) prime_self_import (basic-with_fd_dup)
[202.887924] Starting subtest: basic-with_fd_dup
[202.952858] Subtest basic-with_fd_dup: SUCCESS (0.067s)
[203.189748] [134/162] (811s left) prime_self_import (basic-with_one_bo)
[203.280459] Starting subtest: basic-with_one_bo
[203.340844] Subtest basic-with_one_bo: SUCCESS (0.066s)
[203.567388] [135/162] (811s left) prime_self_import (basic-with_one_bo_two_files)
[203.654943] Starting subtest: basic-with_one_bo_two_files
[203.717775] Subtest basic-with_one_bo_two_files: SUCCESS (0.065s)
[203.891057] [136/162] (811s left) prime_self_import (basic-with_two_bos)
[203.979555] Starting subtest: basic-with_two_bos
[204.041990] Subtest basic-with_two_bos: SUCCESS (0.065s)
[204.259468] [137/162] (811s left) prime_vgem (basic-fence-flip)
[204.400944] Starting subtest: basic-fence-flip
[204.551820] Subtest basic-fence-flip: SKIP (0.148s)
[204.794499] [138/162] (810s left) prime_vgem (basic-fence-mmap)
[204.936802] Starting subtest: basic-fence-mmap
[204.940405] Subtest basic-fence-mmap: SKIP (0.000s)
[205.168457] [139/162] (810s left) prime_vgem (basic-fence-read)
[205.320461] Starting subtest: basic-fence-read
[205.342638] Subtest basic-fence-read: SKIP (0.022s)
[205.569662] [140/162] (810s left) prime_vgem (basic-gtt)
[205.715208] Starting subtest: basic-gtt
[205.718415] Subtest basic-gtt: SKIP (0.000s)
[205.959449] [141/162] (809s left) prime_vgem (basic-read)
[206.100522] Starting subtest: basic-read
[206.119786] Subtest basic-read: SKIP (0.018s)
[206.311686] [142/162] (809s left) prime_vgem (basic-write)
[206.452915] Starting subtest: basic-write
[206.468812] Subtest basic-write: SKIP (0.014s)
[206.717493] [143/162] (809s left) vgem_basic (setversion)
[206.826502] Starting subtest: setversion
[206.829999] Subtest setversion: SUCCESS (0.000s)
[207.020775] [144/162] (809s left) vgem_basic (create)
[207.126916] Starting subtest: create
[207.129168] Subtest create: SUCCESS (0.000s)
[207.281525] [145/162] (809s left) vgem_basic (debugfs)
[207.377537] Starting subtest: debugfs
[207.379316] Subtest debugfs: SUCCESS (0.001s)
[207.575347] [146/162] (808s left) vgem_basic (dmabuf-export)
[207.710951] Starting subtest: dmabuf-export
[207.746955] Subtest dmabuf-export: SUCCESS (0.036s)
[207.974676] [147/162] (808s left) vgem_basic (dmabuf-fence)
[208.075912] Starting subtest: dmabuf-fence
[208.077525] Subtest dmabuf-fence: SUCCESS (0.001s)
[208.242394] [148/162] (808s left) vgem_basic (dmabuf-fence-before)
[208.342776] Starting subtest: dmabuf-fence-before
[208.344516] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[208.538186] [149/162] (808s left) vgem_basic (dmabuf-mmap)
[208.642828] Starting subtest: dmabuf-mmap
[208.668018] Subtest dmabuf-mmap: SUCCESS (0.026s)
[208.805806] [150/162] (808s left) vgem_basic (mmap)
[208.911718] Starting subtest: mmap
[208.928387] Subtest mmap: SUCCESS (0.019s)
[209.073681] [151/162] (807s left) vgem_basic (second-client)
[209.176339] Starting subtest: second-client
[209.225638] Subtest second-client: SUCCESS (0.037s)
[209.431821] [152/162] (807s left) vgem_basic (sysfs)
[209.526230] Starting subtest: sysfs
[209.527949] Subtest sysfs: SUCCESS (0.001s)
[209.720491] [153/162] (807s left) core_hotunplug (unbind-rebind)
[209.929007] Starting subtest: unbind-rebind
[214.288189] Subtest unbind-rebind: SUCCESS (4.363s)
[214.388335] [154/162] (802s left) vgem_basic (unload)
[214.480192] Starting subtest: unload
[243.706747] Subtest unload: SUCCESS (29.222s)
[243.934344] [155/162] (773s left) i915_module_load (reload)
[244.022441] Starting subtest: reload
[247.796333] Subtest reload: SUCCESS (3.760s)
[247.915369] [156/162] (769s left) gem_lmem_swapping (basic)
[253.545366] Starting subtest: basic
[253.553456] Starting dynamic subtest: lmem0
[292.289124] Dynamic subtest lmem0: SUCCESS (38.745s)
[292.297515] Subtest basic: SUCCESS (38.747s)
[296.254291] [FACT gem_lmem_swapping (basic)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[296.256193] [FACT gem_lmem_swapping (basic)] deleted: kernel.kmod_is_loaded.i915: true
[296.259417] [157/162] (721s left) gem_lmem_swapping (parallel-random-engines)
[298.072742] Starting subtest: parallel-random-engines
[298.076902] Starting dynamic subtest: lmem0
[343.518614] Dynamic subtest lmem0: SUCCESS (45.439s)
[343.520978] Subtest parallel-random-engines: SUCCESS (45.445s)
[345.334960] [158/162] (672s left) gem_lmem_swapping (random-engines)
[347.112520] Starting subtest: random-engines
[347.114313] Starting dynamic subtest: lmem0
[349.143584] Dynamic subtest lmem0: SUCCESS (2.029s)
[349.145129] Subtest random-engines: SUCCESS (2.031s)
[351.737865] [159/162] (666s left) gem_lmem_swapping (verify-random)
[353.480688] Starting subtest: verify-random
[353.483185] Starting dynamic subtest: lmem0
[369.463167] Dynamic subtest lmem0: SUCCESS (15.986s)
[369.464949] Subtest verify-random: SUCCESS (15.987s)
[371.229696] [160/162] (646s left) i915_pm_rpm (module-reload)
[375.318837] Starting subtest: module-reload
[388.746821] Subtest module-reload: SUCCESS (13.427s)
[388.811895] [161/162] (629s left) i915_selftest (live)
[388.891522] Starting subtest: live
[388.893132] Starting dynamic subtest: sanitycheck
[390.847061] Dynamic subtest sanitycheck: SUCCESS (1.907s)
[390.866381] Starting dynamic subtest: uncore
[393.220612] Dynamic subtest uncore: SUCCESS (2.330s)
[393.236778] Starting dynamic subtest: workarounds
[397.852608] Dynamic subtest workarounds: SUCCESS (4.644s)
[397.872587] Aborting: Lockdep not active

/proc/lockdep_stats contents:
 lock-classes:                         2615 [max: 8192]
 dynamic-keys:                          805
 direct dependencies:                 35772 [max: 524288]
 indirect dependencies:              185237
 all direct dependencies:            116528
 dependency chains:                  119348 [max: 524288]
 dependency chain hlocks used:       606780 [max: 2621440]
 dependency chain hlocks lost:            0
 in-hardirq chains:                      16
 in-softirq chains:                       0
 in-process chains:                     164
 stack-trace entries:                524288 [max: 524288]
 number of stack traces:              22167
 number of stack hash chains:         12145
 combined max dependencies:            2805
 hardirq-safe locks:                     26
 hardirq-unsafe locks:                 1553
 softirq-safe locks:                      0
 softirq-unsafe locks:                 1440
 irq-safe locks:                         26
 irq-unsafe locks:                     1553
 hardirq-read-safe locks:                 2
 hardirq-read-unsafe locks:             418
 softirq-read-safe locks:                 0
 softirq-read-unsafe locks:             415
 irq-read-safe locks:                     2
 irq-read-unsafe locks:                 418
 uncategorized locks:                   729
 unused locks:                            1
 max locking depth:                      22
 max bfs queue depth:                  1223
 max lock class index:                 2768
 debug_locks:                             0

 zapped classes:                       1628
 zapped lock chains:                  86016
 large chain blocks:                    378

[397.875972] Starting dynamic subtest: gt_engines
[399.836332] Dynamic subtest gt_engines: SUCCESS (1.984s)
[399.840804] Starting dynamic subtest: gt_timelines