[36.194341] Initializing watchdogs
[36.194392]   /dev/watchdog0
[36.209466] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d51 Intel Meteorlake (Gen12) 
[36.228113] [001/162] (960s left) i915_module_load (load)
[36.353542] Starting subtest: load
[39.406609] Subtest load: SUCCESS (3.054s)
[39.514304] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[39.518594] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[39.534829] [002/162] (957s left) core_auth (basic-auth)
[40.790993] Starting subtest: basic-auth
[40.797770] Subtest basic-auth: SUCCESS (0.002s)
[40.954156] [003/162] (956s left) core_debugfs (read-all-entries)
[41.083010] Starting subtest: read-all-entries
[41.227825] Subtest read-all-entries: SUCCESS (0.168s)
[41.383123] [004/162] (955s left) core_sysfs (read-all-entries)
[41.506212] Starting subtest: read-all-entries
[41.512717] Subtest read-all-entries: SUCCESS (0.010s)
[41.673299] [005/162] (955s left) fbdev (eof)
[41.795584] Starting subtest: eof
[41.802291] Subtest eof: SUCCESS (0.000s)
[41.954974] [006/162] (955s left) fbdev (info)
[42.061390] Starting subtest: info
[42.070149] Subtest info: SUCCESS (0.000s)
[42.232639] [007/162] (955s left) fbdev (nullptr)
[42.348123] Starting subtest: nullptr
[42.361345] Subtest nullptr: SUCCESS (0.000s)
[42.495063] [008/162] (955s left) fbdev (read)
[42.596929] Starting subtest: read
[44.089716] Subtest read: SUCCESS (1.479s)
[44.233344] [009/162] (953s left) fbdev (write)
[44.356626] Starting subtest: write
[45.408485] Subtest write: SUCCESS (1.048s)
[45.539289] [010/162] (952s left) gem_basic (bad-close)
[45.610615] Starting subtest: bad-close
[45.627466] Subtest bad-close: SUCCESS (0.000s)
[45.829182] [011/162] (952s left) gem_basic (create-close)
[45.901135] Starting subtest: create-close
[45.924808] Subtest create-close: SUCCESS (0.000s)
[46.124773] [012/162] (951s left) gem_basic (create-fd-close)
[46.210617] Starting subtest: create-fd-close
[46.234275] Subtest create-fd-close: SUCCESS (0.000s)
[46.419438] [013/162] (951s left) gem_busy (busy@all-engines)
[46.493133] Starting subtest: busy
[46.506067] Starting dynamic subtest: all-engines
[46.536375] Dynamic subtest all-engines: SUCCESS (0.046s)
[46.542893] Subtest busy: SUCCESS (0.047s)
[47.963681] [014/162] (950s left) gem_close_race (basic-process)
[48.056172] Starting subtest: basic-process
[48.105926] Subtest basic-process: SUCCESS (0.053s)
[48.342940] [015/162] (949s left) gem_close_race (basic-threads)
[48.408843] Starting subtest: basic-threads
[49.792225] Subtest basic-threads: SUCCESS (1.366s)
[50.040914] [016/162] (948s left) gem_ctx_create (basic)
[50.113185] Starting subtest: basic
[50.129845] Subtest basic: SUCCESS (0.000s)
[50.369108] [017/162] (948s left) gem_ctx_create (basic-files)
[50.451757] Starting subtest: basic-files
[52.460581] Subtest basic-files: SUCCESS (1.998s)
[54.060919] [018/162] (944s left) gem_ctx_exec (basic)
[54.140165] Starting subtest: basic
[54.149046] Subtest basic: SUCCESS (0.010s)
[54.319273] [019/162] (944s left) gem_exec_basic (basic)
[54.403499] Starting subtest: basic
[54.412276] Starting dynamic subtest: rcs0-smem
[54.425590] Dynamic subtest rcs0-smem: SUCCESS (0.005s)
[54.436605] Starting dynamic subtest: bcs0-smem
[54.448947] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[54.459780] Starting dynamic subtest: vcs0-smem
[54.475108] Dynamic subtest vcs0-smem: SUCCESS (0.003s)
[54.493111] Starting dynamic subtest: vcs1-smem
[54.501935] Dynamic subtest vcs1-smem: SUCCESS (0.003s)
[54.521377] Starting dynamic subtest: vecs0-smem
[54.527737] Dynamic subtest vecs0-smem: SUCCESS (0.003s)
[54.544449] Starting dynamic subtest: ccs0-smem
[54.550718] Dynamic subtest ccs0-smem: SUCCESS (0.004s)
[54.567317] Subtest basic: SUCCESS (0.023s)
[55.927523] [020/162] (942s left) gem_exec_create (basic)
[55.995447] Starting subtest: basic
[56.001896] Starting dynamic subtest: smem
[59.813157] Dynamic subtest smem: SUCCESS (3.811s)
[59.824375] Subtest basic: SUCCESS (3.812s)
[60.152211] [021/162] (938s left) gem_exec_fence (basic-busy)
[60.350477] Starting subtest: basic-busy
[60.364011] Starting dynamic subtest: rcs0
[60.433343] Dynamic subtest rcs0: SUCCESS (0.094s)
[60.455170] Starting dynamic subtest: bcs0
[60.494363] Dynamic subtest bcs0: SUCCESS (0.060s)
[60.505339] Starting dynamic subtest: vcs0
[60.561251] Dynamic subtest vcs0: SUCCESS (0.066s)
[60.572140] Starting dynamic subtest: vcs1
[60.637454] Dynamic subtest vcs1: SUCCESS (0.072s)
[60.654626] Starting dynamic subtest: vecs0
[60.699162] Dynamic subtest vecs0: SUCCESS (0.065s)
[60.709870] Starting dynamic subtest: ccs0
[60.760542] Dynamic subtest ccs0: SUCCESS (0.066s)
[60.773152] Subtest basic-busy: SUCCESS (0.424s)
[63.104741] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[63.113209] [022/162] (935s left) gem_exec_fence (basic-wait)
[63.288482] Starting subtest: basic-wait
[63.297040] Starting dynamic subtest: rcs0
[63.385872] Dynamic subtest rcs0: SUCCESS (0.099s)
[63.407758] Starting dynamic subtest: bcs0
[63.445152] Dynamic subtest bcs0: SUCCESS (0.057s)
[63.456328] Starting dynamic subtest: vcs0
[63.500724] Dynamic subtest vcs0: SUCCESS (0.058s)
[63.520765] Starting dynamic subtest: vcs1
[63.558716] Dynamic subtest vcs1: SUCCESS (0.061s)
[63.577969] Starting dynamic subtest: vecs0
[63.616636] Dynamic subtest vecs0: SUCCESS (0.053s)
[63.627661] Starting dynamic subtest: ccs0
[63.677297] Dynamic subtest ccs0: SUCCESS (0.060s)
[63.683471] Subtest basic-wait: SUCCESS (0.388s)
[65.965692] [023/162] (933s left) gem_exec_fence (basic-await)
[66.130967] Starting subtest: basic-await
[66.144428] Starting dynamic subtest: rcs0
[66.229712] Dynamic subtest rcs0: SUCCESS (0.094s)
[66.250848] Starting dynamic subtest: bcs0
[66.316892] Dynamic subtest bcs0: SUCCESS (0.086s)
[66.332613] Starting dynamic subtest: vcs0
[66.392447] Dynamic subtest vcs0: SUCCESS (0.081s)
[66.412126] Starting dynamic subtest: vcs1
[66.479769] Dynamic subtest vcs1: SUCCESS (0.081s)
[66.501928] Starting dynamic subtest: vecs0
[66.557675] Dynamic subtest vecs0: SUCCESS (0.077s)
[66.579815] Starting dynamic subtest: ccs0
[66.637865] Dynamic subtest ccs0: SUCCESS (0.080s)
[66.644183] Subtest basic-await: SUCCESS (0.502s)
[68.065993] [024/162] (931s left) gem_exec_fence (nb-await)
[68.257696] Starting subtest: nb-await
[68.270188] Starting dynamic subtest: rcs0
[68.334749] Dynamic subtest rcs0: SUCCESS (0.085s)
[68.354403] Starting dynamic subtest: bcs0
[68.405804] Dynamic subtest bcs0: SUCCESS (0.064s)
[68.423655] Starting dynamic subtest: vcs0
[68.461669] Dynamic subtest vcs0: SUCCESS (0.061s)
[68.481223] Starting dynamic subtest: vcs1
[68.532462] Dynamic subtest vcs1: SUCCESS (0.064s)
[68.550431] Starting dynamic subtest: vecs0
[68.588991] Dynamic subtest vecs0: SUCCESS (0.062s)
[68.608544] Starting dynamic subtest: ccs0
[68.653099] Dynamic subtest ccs0: SUCCESS (0.058s)
[68.659204] Subtest nb-await: SUCCESS (0.397s)
[70.998730] [025/162] (928s left) gem_exec_gttfill (basic)
[71.070117] Starting subtest: basic
[75.024112] Subtest basic: SUCCESS (3.959s)
[75.268779] [026/162] (924s left) gem_exec_parallel (engines)
[75.360104] Starting subtest: engines
[75.368710] Starting dynamic subtest: basic
[78.883399] Dynamic subtest basic: SUCCESS (3.512s)
[78.901261] Starting dynamic subtest: contexts
[84.276418] Dynamic subtest contexts: SUCCESS (5.388s)
[84.294250] Starting dynamic subtest: fds
[89.872534] Dynamic subtest fds: SUCCESS (5.593s)
[89.891410] Starting dynamic subtest: userptr
[91.816375] Dynamic subtest userptr: SUCCESS (1.937s)
[91.822881] Subtest engines: SUCCESS (16.433s)
[92.072094] [027/162] (907s left) gem_exec_store (basic)
[92.182445] Starting subtest: basic
[92.278574] Subtest basic: SUCCESS (0.137s)
[92.518393] [028/162] (907s left) gem_flink_basic (bad-flink)
[92.589598] Starting subtest: bad-flink
[92.605247] Subtest bad-flink: SUCCESS (0.000s)
[92.708933] [029/162] (906s left) gem_flink_basic (bad-open)
[92.777538] Starting subtest: bad-open
[92.785954] Subtest bad-open: SUCCESS (0.000s)
[92.884713] [030/162] (906s left) gem_flink_basic (basic)
[92.955165] Starting subtest: basic
[92.970876] Subtest basic: SUCCESS (0.000s)
[93.084619] [031/162] (906s left) gem_flink_basic (double-flink)
[93.155953] Starting subtest: double-flink
[93.171544] Subtest double-flink: SUCCESS (0.000s)
[93.307709] [032/162] (906s left) gem_flink_basic (flink-lifetime)
[93.381567] Starting subtest: flink-lifetime
[93.397241] Subtest flink-lifetime: SUCCESS (0.001s)
[93.541275] [033/162] (906s left) gem_huc_copy (huc-copy)
[93.603868] Starting subtest: huc-copy
[93.613634] Subtest huc-copy: SUCCESS (0.004s)
[93.812565] [034/162] (906s left) gem_linear_blits (basic)
[93.955472] Starting subtest: basic
[93.971296] Subtest basic: SUCCESS (0.025s)
[94.206574] [035/162] (905s left) gem_mmap (basic)
[94.306327] Subtest basic: SKIP (0.000s)
[94.431518] [036/162] (905s left) gem_mmap_gtt (basic)
[94.506193] Subtest basic: SKIP (0.000s)
[94.677184] [037/162] (905s left) gem_render_linear_blits (basic)
[94.739232] Starting subtest: basic
[94.780753] Subtest basic: SUCCESS (0.027s)
[94.966046] [038/162] (905s left) gem_render_tiled_blits (basic)
[95.029818] Subtest basic: SKIP (0.000s)
[95.180180] [039/162] (905s left) gem_ringfill (basic-all)
[100.840941] Starting subtest: basic-all
[102.004899] Subtest basic-all: SUCCESS (1.171s)
[102.179458] [040/162] (898s left) gem_softpin (allocator-basic)
[102.240207] Starting subtest: allocator-basic
[102.320355] Subtest allocator-basic: SUCCESS (0.093s)
[102.558126] [041/162] (898s left) gem_softpin (allocator-basic-reserve)
[102.615257] Starting subtest: allocator-basic-reserve
[102.692699] Subtest allocator-basic-reserve: SUCCESS (0.083s)
[102.925303] [042/162] (897s left) gem_softpin (safe-alignment)
[102.989535] Starting subtest: safe-alignment
[103.031127] Subtest safe-alignment: SUCCESS (0.044s)
[104.958086] [043/162] (895s left) gem_sync (basic-all)
[105.126230] Starting subtest: basic-all
[108.836324] Subtest basic-all: SUCCESS (3.800s)
[109.067220] [044/162] (891s left) gem_sync (basic-each)
[109.225227] Starting subtest: basic-each
[111.583632] Subtest basic-each: SUCCESS (2.445s)
[111.843777] [045/162] (889s left) gem_tiled_blits (basic)
[111.937931] Subtest basic: SKIP (0.000s)
[112.002737] [046/162] (889s left) gem_tiled_fence_blits (basic)
[112.075182] Subtest basic: SKIP (0.000s)
[112.128967] [047/162] (889s left) gem_tiled_pread_basic (basic)
[112.205848] Subtest basic: SKIP (0.000s)
[112.260771] [048/162] (888s left) gem_wait (busy@all-engines)
[112.324265] Starting subtest: busy
[112.333609] Starting dynamic subtest: all-engines
[113.825656] Dynamic subtest all-engines: SUCCESS (1.495s)
[113.834841] Subtest busy: SUCCESS (1.496s)
[114.091539] [049/162] (887s left) gem_wait (wait@all-engines)
[114.153353] Starting subtest: wait
[114.162690] Starting dynamic subtest: all-engines
[115.874294] Dynamic subtest all-engines: SUCCESS (1.712s)
[115.883412] Subtest wait: SUCCESS (1.713s)
[116.092485] [050/162] (885s left) i915_getparams_basic (basic-eu-total)
[116.155720] Starting subtest: basic-eu-total
[116.168723] Subtest basic-eu-total: SUCCESS (0.000s)
[116.250865] [051/162] (885s left) i915_getparams_basic (basic-subslice-total)
[116.297565] Starting subtest: basic-subslice-total
[116.309940] Subtest basic-subslice-total: SUCCESS (0.000s)
[116.401395] [052/162] (885s left) i915_hangman (error-state-basic)
[116.461428] Starting subtest: error-state-basic
[116.594445] Subtest error-state-basic: SUCCESS (0.134s)
[116.725629] [053/162] (884s left) i915_pciid
[116.887124] [054/162] (884s left) intel_hwmon (hwmon-read)
[116.952425] Subtest hwmon-read: SKIP (0.000s)
[117.012304] [055/162] (884s left) intel_hwmon (hwmon-write)
[117.094213] Subtest hwmon-write: SKIP (0.000s)
[117.161244] [056/162] (884s left) kms_addfb_basic (addfb25-4-tiled)
[117.272724] Starting subtest: addfb25-4-tiled
[117.278829] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[117.401282] [057/162] (884s left) kms_addfb_basic (addfb25-bad-modifier)
[117.481975] Starting subtest: addfb25-bad-modifier
[117.493539] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[117.647282] [058/162] (884s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[117.739037] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[117.892717] [059/162] (883s left) kms_addfb_basic (addfb25-modifier-no-flag)
[117.987517] Starting subtest: addfb25-modifier-no-flag
[118.003889] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[118.150788] [060/162] (883s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[118.243014] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[118.385949] [061/162] (883s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[118.472043] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[118.608913] [062/162] (883s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[118.693454] Starting subtest: addfb25-yf-tiled-legacy
[118.699642] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[118.865824] [063/162] (883s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[118.944292] Starting subtest: addfb25-y-tiled-legacy
[118.950408] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[119.071154] [064/162] (883s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[119.149765] Starting subtest: addfb25-y-tiled-small-legacy
[119.162033] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[119.307669] [065/162] (882s left) kms_addfb_basic (bad-pitch-0)
[119.363380] Starting subtest: bad-pitch-0
[119.369661] Subtest bad-pitch-0: SUCCESS (0.000s)
[119.533688] [066/162] (882s left) kms_addfb_basic (bad-pitch-1024)
[119.589315] Starting subtest: bad-pitch-1024
[119.596989] Subtest bad-pitch-1024: SUCCESS (0.000s)
[119.751836] [067/162] (882s left) kms_addfb_basic (bad-pitch-128)
[119.808264] Starting subtest: bad-pitch-128
[119.814657] Subtest bad-pitch-128: SUCCESS (0.000s)
[119.997626] [068/162] (882s left) kms_addfb_basic (bad-pitch-256)
[120.050425] Starting subtest: bad-pitch-256
[120.058115] Subtest bad-pitch-256: SUCCESS (0.000s)
[120.204468] [069/162] (882s left) kms_addfb_basic (bad-pitch-32)
[120.276887] Starting subtest: bad-pitch-32
[120.293445] Subtest bad-pitch-32: SUCCESS (0.000s)
[120.565738] [070/162] (881s left) kms_addfb_basic (bad-pitch-63)
[120.642869] Starting subtest: bad-pitch-63
[120.654484] Subtest bad-pitch-63: SUCCESS (0.000s)
[120.806917] [071/162] (881s left) kms_addfb_basic (bad-pitch-65536)
[120.893921] Starting subtest: bad-pitch-65536
[120.900198] Subtest bad-pitch-65536: SUCCESS (0.000s)
[121.066952] [072/162] (881s left) kms_addfb_basic (bad-pitch-999)
[121.136707] Starting subtest: bad-pitch-999
[121.149108] Subtest bad-pitch-999: SUCCESS (0.000s)
[121.328201] [073/162] (881s left) kms_addfb_basic (basic)
[121.399627] Starting subtest: basic
[121.416031] Subtest basic: SUCCESS (0.000s)
[121.578365] [074/162] (881s left) kms_addfb_basic (basic-x-tiled-legacy)
[121.665668] Starting subtest: basic-x-tiled-legacy
[121.687869] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[121.824608] [075/162] (880s left) kms_addfb_basic (basic-y-tiled-legacy)
[121.895573] Starting subtest: basic-y-tiled-legacy
[121.917967] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[122.070260] [076/162] (880s left) kms_addfb_basic (bo-too-small)
[122.151083] Starting subtest: bo-too-small
[122.162720] Subtest bo-too-small: SUCCESS (0.000s)
[122.325029] [077/162] (880s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[122.421333] Starting subtest: bo-too-small-due-to-tiling
[122.444035] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[122.582938] [078/162] (880s left) kms_addfb_basic (clobberred-modifier)
[122.653450] Starting subtest: clobberred-modifier
[122.675449] Subtest clobberred-modifier: SKIP (0.000s)
[122.962648] [079/162] (880s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[123.049694] Starting subtest: framebuffer-vs-set-tiling
[123.076787] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[123.186642] [080/162] (880s left) kms_addfb_basic (invalid-get-prop)
[123.266879] Starting subtest: invalid-get-prop
[123.273323] Subtest invalid-get-prop: SUCCESS (0.000s)
[123.423934] [081/162] (879s left) kms_addfb_basic (invalid-get-prop-any)
[123.495695] Starting subtest: invalid-get-prop-any
[123.512243] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[123.672688] [082/162] (879s left) kms_addfb_basic (invalid-set-prop)
[123.745233] Starting subtest: invalid-set-prop
[123.751559] Subtest invalid-set-prop: SUCCESS (0.000s)
[123.913791] [083/162] (879s left) kms_addfb_basic (invalid-set-prop-any)
[123.998383] Starting subtest: invalid-set-prop-any
[124.007102] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[124.172584] [084/162] (879s left) kms_addfb_basic (no-handle)
[124.262753] Starting subtest: no-handle
[124.271553] Subtest no-handle: SUCCESS (0.000s)
[124.455063] [085/162] (879s left) kms_addfb_basic (size-max)
[124.555035] Starting subtest: size-max
[124.568448] Subtest size-max: SUCCESS (0.000s)
[124.804580] [086/162] (878s left) kms_addfb_basic (small-bo)
[124.898122] Starting subtest: small-bo
[124.914609] Subtest small-bo: SUCCESS (0.000s)
[125.071172] [087/162] (878s left) kms_addfb_basic (tile-pitch-mismatch)
[125.143530] Starting subtest: tile-pitch-mismatch
[125.163151] Subtest tile-pitch-mismatch: SKIP (0.000s)
[125.314462] [088/162] (878s left) kms_addfb_basic (too-high)
[125.387125] Starting subtest: too-high
[125.393336] Subtest too-high: SUCCESS (0.000s)
[125.532999] [089/162] (878s left) kms_addfb_basic (too-wide)
[125.606657] Starting subtest: too-wide
[125.612887] Subtest too-wide: SUCCESS (0.000s)
[125.765625] [090/162] (878s left) kms_addfb_basic (unused-handle)
[125.820777] Starting subtest: unused-handle
[125.827397] Subtest unused-handle: SUCCESS (0.000s)
[126.013667] [091/162] (877s left) kms_addfb_basic (unused-modifier)
[126.070512] Starting subtest: unused-modifier
[126.076884] Subtest unused-modifier: SUCCESS (0.000s)
[126.266427] [092/162] (877s left) kms_addfb_basic (unused-offsets)
[126.352978] Starting subtest: unused-offsets
[126.359476] Subtest unused-offsets: SUCCESS (0.000s)
[126.510227] [093/162] (877s left) kms_addfb_basic (unused-pitches)
[126.598550] Starting subtest: unused-pitches
[126.604752] Subtest unused-pitches: SUCCESS (0.000s)
[126.754459] [094/162] (877s left) kms_busy (basic)
[126.842258] Starting subtest: basic
[126.855781] Starting dynamic subtest: flip
[127.561832] Dynamic subtest flip: SUCCESS (0.715s)
[127.579577] Starting dynamic subtest: modeset
[131.004718] Dynamic subtest modeset: SUCCESS (3.448s)
[131.011095] Subtest basic: SUCCESS (4.164s)
[131.852206] [095/162] (872s left) kms_prop_blob (basic)
[131.917468] Starting subtest: basic
[131.932929] Subtest basic: SUCCESS (0.000s)
[132.018244] [096/162] (872s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[132.140647] Starting subtest: basic-busy-flip-before-cursor-atomic
[132.162727] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[132.314093] [097/162] (871s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[132.432803] Starting subtest: basic-busy-flip-before-cursor-legacy
[132.455830] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[132.604555] [098/162] (871s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[132.709936] Starting subtest: basic-flip-after-cursor-atomic
[133.921318] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.213s)
[134.796699] [099/162] (869s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[134.911755] Starting subtest: basic-flip-after-cursor-legacy
[136.126233] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.214s)
[137.013853] [100/162] (867s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[137.130677] Starting subtest: basic-flip-after-cursor-varying-size
[138.334340] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.214s)
[139.253683] [101/162] (865s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[139.379224] Starting subtest: basic-flip-before-cursor-atomic
[140.580272] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.213s)
[141.526900] [102/162] (863s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[141.648525] Starting subtest: basic-flip-before-cursor-legacy
[142.852875] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.210s)
[143.753368] [103/162] (860s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[143.875284] Starting subtest: basic-flip-before-cursor-varying-size
[145.085535] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.207s)
[146.040237] [104/162] (858s left) kms_dsc (dsc-basic)
[146.128331] Starting subtest: dsc-basic
[146.178326] Subtest dsc-basic: SKIP (0.001s)
[146.248982] [105/162] (858s left) kms_flip (basic-flip-vs-dpms)
[146.338750] Starting subtest: basic-flip-vs-dpms
[146.349397] Starting dynamic subtest: A-eDP1
[148.904117] Dynamic subtest A-eDP1: SUCCESS (2.573s)
[148.947406] Starting dynamic subtest: B-eDP1
[151.072382] Dynamic subtest B-eDP1: SUCCESS (2.167s)
[151.091074] Starting dynamic subtest: C-eDP1
[153.246255] Dynamic subtest C-eDP1: SUCCESS (2.171s)
[153.266559] Starting dynamic subtest: D-eDP1
[155.416095] Dynamic subtest D-eDP1: SUCCESS (2.171s)
[155.432705] Subtest basic-flip-vs-dpms: SUCCESS (9.090s)
[156.271663] [106/162] (848s left) kms_flip (basic-flip-vs-modeset)
[156.374563] Starting subtest: basic-flip-vs-modeset
[156.380771] Starting dynamic subtest: A-eDP1
[158.913355] Dynamic subtest A-eDP1: SUCCESS (2.552s)
[158.931185] Starting dynamic subtest: B-eDP1
[161.077091] Dynamic subtest B-eDP1: SUCCESS (2.160s)
[161.089784] Starting dynamic subtest: C-eDP1
[163.257126] Dynamic subtest C-eDP1: SUCCESS (2.180s)
[163.277487] Starting dynamic subtest: D-eDP1
[165.421145] Dynamic subtest D-eDP1: SUCCESS (2.167s)
[165.437715] Subtest basic-flip-vs-modeset: SUCCESS (9.068s)
[166.295668] [107/162] (838s left) kms_flip (basic-flip-vs-wf_vblank)
[166.377549] Starting subtest: basic-flip-vs-wf_vblank
[166.383755] Starting dynamic subtest: A-eDP1
[168.425439] Dynamic subtest A-eDP1: SUCCESS (2.051s)
[168.444631] Starting dynamic subtest: B-eDP1
[170.459860] Dynamic subtest B-eDP1: SUCCESS (2.033s)
[170.479265] Starting dynamic subtest: C-eDP1
[172.494761] Dynamic subtest C-eDP1: SUCCESS (2.026s)
[172.514667] Starting dynamic subtest: D-eDP1
[174.549253] Dynamic subtest D-eDP1: SUCCESS (2.046s)
[174.557945] Subtest basic-flip-vs-wf_vblank: SUCCESS (8.171s)
[175.888760] [108/162] (829s left) kms_flip (basic-plain-flip)
[175.979607] Starting subtest: basic-plain-flip
[175.988899] Starting dynamic subtest: A-eDP1
[177.663436] Dynamic subtest A-eDP1: SUCCESS (1.691s)
[177.685096] Starting dynamic subtest: B-eDP1
[179.378469] Dynamic subtest B-eDP1: SUCCESS (1.712s)
[179.402096] Starting dynamic subtest: C-eDP1
[181.106159] Dynamic subtest C-eDP1: SUCCESS (1.717s)
[181.128021] Starting dynamic subtest: D-eDP1
[182.844847] Dynamic subtest D-eDP1: SUCCESS (1.737s)
[182.853578] Subtest basic-plain-flip: SUCCESS (6.864s)
[184.166521] [109/162] (821s left) kms_force_connector_basic (force-connector-state)
[184.253036] Starting subtest: force-connector-state
[184.831096] Subtest force-connector-state: SUCCESS (0.595s)
[185.880149] [110/162] (819s left) kms_force_connector_basic (force-edid)
[185.952125] Starting subtest: force-edid
[186.247318] Subtest force-edid: SUCCESS (0.290s)
[186.417121] [111/162] (818s left) kms_force_connector_basic (force-load-detect)
[186.507974] Starting subtest: force-load-detect
[186.531135] Subtest force-load-detect: SKIP (0.000s)
[186.705063] [112/162] (818s left) kms_force_connector_basic (prune-stale-modes)
[186.775492] Starting subtest: prune-stale-modes
[187.133225] Subtest prune-stale-modes: SUCCESS (0.351s)
[187.408710] [113/162] (818s left) kms_frontbuffer_tracking (basic)
[187.518703] Starting subtest: basic
[192.856464] Subtest basic: SUCCESS (5.353s)
[193.081695] [114/162] (812s left) kms_hdmi_inject (inject-audio)
[193.426501] Starting subtest: inject-audio
[193.666765] Subtest inject-audio: SUCCESS (0.248s)
[194.309478] [115/162] (811s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[194.395999] Starting subtest: compare-crc-sanitycheck-xr24
[194.412463] Starting dynamic subtest: pipe-A-eDP-1
[195.119956] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.730s)
[195.137715] Starting dynamic subtest: pipe-B-eDP-1
[196.437057] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.318s)
[196.454926] Starting dynamic subtest: pipe-C-eDP-1
[197.692714] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.252s)
[197.710717] Starting dynamic subtest: pipe-D-eDP-1
[198.976609] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.284s)
[198.993159] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.591s)
[199.870880] [116/162] (806s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[199.971829] Starting subtest: compare-crc-sanitycheck-nv12
[199.980666] Starting dynamic subtest: pipe-A-eDP-1
[200.872802] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.911s)
[200.890554] Starting dynamic subtest: pipe-B-eDP-1
[202.339630] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.450s)
[202.361440] Starting dynamic subtest: pipe-C-eDP-1
[203.631977] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.301s)
[203.649830] Starting dynamic subtest: pipe-D-eDP-1
[204.951055] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.313s)
[204.961454] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.987s)
[205.871737] [117/162] (800s left) kms_pipe_crc_basic (hang-read-crc)
[205.963654] Starting subtest: hang-read-crc
[205.969887] Starting dynamic subtest: pipe-A-eDP-1
[208.325099] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.367s)
[208.342840] Starting dynamic subtest: pipe-B-eDP-1
[211.335908] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.007s)
[211.353647] Starting dynamic subtest: pipe-C-eDP-1
[214.375904] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.032s)
[214.393598] Starting dynamic subtest: pipe-D-eDP-1
[217.373147] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.989s)
[217.382903] Subtest hang-read-crc: SUCCESS (11.405s)
[218.271874] [118/162] (787s left) kms_pipe_crc_basic (nonblocking-crc)
[218.355172] Starting subtest: nonblocking-crc
[218.361425] Starting dynamic subtest: pipe-A-eDP-1
[219.231970] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.871s)
[219.249750] Starting dynamic subtest: pipe-B-eDP-1
[220.702838] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.475s)
[220.721744] Starting dynamic subtest: pipe-C-eDP-1
[222.158804] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.454s)
[222.177657] Starting dynamic subtest: pipe-D-eDP-1
[223.647296] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.483s)
[223.653399] Subtest nonblocking-crc: SUCCESS (5.290s)
[224.568297] [119/162] (781s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[224.647653] Starting subtest: nonblocking-crc-frame-sequence
[224.653845] Starting dynamic subtest: pipe-A-eDP-1
[225.527931] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.877s)
[225.545621] Starting dynamic subtest: pipe-B-eDP-1
[226.996925] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.470s)
[227.014599] Starting dynamic subtest: pipe-C-eDP-1
[228.423917] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.429s)
[228.436929] Starting dynamic subtest: pipe-D-eDP-1
[229.933874] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.500s)
[229.950288] Subtest nonblocking-crc-frame-sequence: SUCCESS (5.283s)
[230.874238] [120/162] (775s left) kms_pipe_crc_basic (read-crc)
[230.970683] Starting subtest: read-crc
[230.987240] Starting dynamic subtest: pipe-A-eDP-1
[231.776603] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.814s)
[231.794376] Starting dynamic subtest: pipe-B-eDP-1
[233.241118] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.460s)
[233.258949] Starting dynamic subtest: pipe-C-eDP-1
[234.665955] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.423s)
[234.681335] Starting dynamic subtest: pipe-D-eDP-1
[236.071737] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.402s)
[236.088363] Subtest read-crc: SUCCESS (5.106s)
[236.976733] [121/162] (769s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[237.071162] Starting subtest: read-crc-frame-sequence
[237.087746] Starting dynamic subtest: pipe-A-eDP-1
[237.862021] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.800s)
[237.875566] Starting dynamic subtest: pipe-B-eDP-1
[239.357163] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.485s)
[239.373109] Starting dynamic subtest: pipe-C-eDP-1
[240.776979] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.424s)
[240.794966] Starting dynamic subtest: pipe-D-eDP-1
[242.177087] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.398s)
[242.193544] Subtest read-crc-frame-sequence: SUCCESS (5.114s)
[243.066712] [122/162] (763s left) kms_pm_backlight (basic-brightness)
[243.144853] Starting subtest: basic-brightness
[243.216636] Starting dynamic subtest: eDP-1
[243.553822] Dynamic subtest eDP-1: SUCCESS (0.338s)
[243.560488] Subtest basic-brightness: SUCCESS (0.402s)
[244.475362] [123/162] (761s left) kms_pm_rpm (basic-pci-d3-state)
[245.989384] Starting subtest: basic-pci-d3-state
[247.456570] Subtest basic-pci-d3-state: SUCCESS (1.464s)
[247.608997] [124/162] (758s left) kms_pm_rpm (basic-rte)
[247.657495] Starting subtest: basic-rte
[250.598336] Subtest basic-rte: SUCCESS (2.939s)
[252.514096] [125/162] (753s left) kms_psr (psr-primary-page-flip)
[252.610524] Starting subtest: psr-primary-page-flip
[252.624141] Starting dynamic subtest: eDP-1
[254.524819] Dynamic subtest eDP-1: SUCCESS (1.918s)
[254.541262] Subtest psr-primary-page-flip: SUCCESS (1.919s)
[255.381473] [126/162] (751s left) kms_psr (psr-cursor-plane-move)
[255.470297] Starting subtest: psr-cursor-plane-move
[255.476621] Starting dynamic subtest: eDP-1
[257.320693] Dynamic subtest eDP-1: SUCCESS (1.860s)
[257.337167] Subtest psr-cursor-plane-move: SUCCESS (1.862s)
[258.186755] [127/162] (748s left) kms_psr (psr-sprite-plane-onoff)
[258.273103] Starting subtest: psr-sprite-plane-onoff
[258.289503] Starting dynamic subtest: eDP-1
[260.260904] Dynamic subtest eDP-1: SUCCESS (1.982s)
[260.277331] Subtest psr-sprite-plane-onoff: SUCCESS (1.983s)
[261.176584] [128/162] (745s left) kms_psr (psr-primary-mmap-gtt)
[261.274317] Starting subtest: psr-primary-mmap-gtt
[261.283703] Starting dynamic subtest: eDP-1
[262.920388] Dynamic subtest eDP-1: SKIP (1.628s)
[262.942487] Subtest psr-primary-mmap-gtt: SKIP (1.629s)
[263.111864] [129/162] (743s left) kms_setmode (basic-clone-single-crtc)
[263.166653] Starting subtest: basic-clone-single-crtc
[263.186134] Subtest basic-clone-single-crtc: SKIP (0.000s)
[263.272622] [130/162] (743s left) i915_pm_rps (basic-api)
[263.335139] Starting subtest: basic-api
[263.357282] Subtest basic-api: SKIP (0.001s)
[263.478721] [131/162] (743s left) prime_self_import (basic-llseek-bad)
[263.548566] Starting subtest: basic-llseek-bad
[263.571484] Subtest basic-llseek-bad: SUCCESS (0.002s)
[263.696464] [132/162] (743s left) prime_self_import (basic-llseek-size)
[263.748198] Starting subtest: basic-llseek-size
[263.760546] Subtest basic-llseek-size: SUCCESS (0.002s)
[263.882795] [133/162] (743s left) prime_self_import (basic-with_fd_dup)
[263.935697] Starting subtest: basic-with_fd_dup
[263.947968] Subtest basic-with_fd_dup: SUCCESS (0.002s)
[264.094834] [134/162] (742s left) prime_self_import (basic-with_one_bo)
[264.173919] Starting subtest: basic-with_one_bo
[264.195916] Subtest basic-with_one_bo: SUCCESS (0.002s)
[264.304551] [135/162] (742s left) prime_self_import (basic-with_one_bo_two_files)
[264.377885] Starting subtest: basic-with_one_bo_two_files
[264.400477] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s)
[264.529984] [136/162] (742s left) prime_self_import (basic-with_two_bos)
[264.582198] Starting subtest: basic-with_two_bos
[264.594573] Subtest basic-with_two_bos: SUCCESS (0.002s)
[264.730195] [137/162] (742s left) prime_vgem (basic-fence-flip)
[264.794678] Starting subtest: basic-fence-flip
[265.225464] Subtest basic-fence-flip: SUCCESS (0.447s)
[265.388195] [138/162] (741s left) prime_vgem (basic-fence-mmap)
[265.464450] Starting subtest: basic-fence-mmap
[265.482449] Subtest basic-fence-mmap: SKIP (0.000s)
[265.597564] [139/162] (741s left) prime_vgem (basic-fence-read)
[265.674749] Starting subtest: basic-fence-read
[265.689844] Subtest basic-fence-read: SKIP (0.013s)
[265.826945] [140/162] (741s left) prime_vgem (basic-gtt)
[265.895476] Starting subtest: basic-gtt
[265.910664] Subtest basic-gtt: SKIP (0.000s)
[266.026947] [141/162] (741s left) prime_vgem (basic-read)
[266.104810] Starting subtest: basic-read
[266.120136] Subtest basic-read: SKIP (0.011s)
[266.241239] [142/162] (741s left) prime_vgem (basic-write)
[266.319179] Starting subtest: basic-write
[266.337967] Subtest basic-write: SKIP (0.010s)
[266.449424] [143/162] (741s left) vgem_basic (setversion)
[266.522243] Starting subtest: setversion
[266.534567] Subtest setversion: SUCCESS (0.000s)
[266.599306] [144/162] (740s left) vgem_basic (create)
[266.658546] Starting subtest: create
[266.664680] Subtest create: SUCCESS (0.000s)
[266.749748] [145/162] (740s left) vgem_basic (debugfs)
[266.803152] Starting subtest: debugfs
[266.809374] Subtest debugfs: SUCCESS (0.000s)
[266.899436] [146/162] (740s left) vgem_basic (dmabuf-export)
[266.957188] Starting subtest: dmabuf-export
[266.969467] Subtest dmabuf-export: SUCCESS (0.003s)
[267.090541] [147/162] (740s left) vgem_basic (dmabuf-fence)
[267.149389] Starting subtest: dmabuf-fence
[267.155596] Subtest dmabuf-fence: SUCCESS (0.000s)
[267.250304] [148/162] (740s left) vgem_basic (dmabuf-fence-before)
[267.304670] Starting subtest: dmabuf-fence-before
[267.310888] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[267.392666] [149/162] (740s left) vgem_basic (dmabuf-mmap)
[267.451601] Starting subtest: dmabuf-mmap
[267.464285] Subtest dmabuf-mmap: SUCCESS (0.018s)
[267.566192] [150/162] (740s left) vgem_basic (mmap)
[267.631923] Starting subtest: mmap
[267.638188] Subtest mmap: SUCCESS (0.012s)
[267.715260] [151/162] (740s left) vgem_basic (second-client)
[267.767477] Starting subtest: second-client
[267.798029] Subtest second-client: SUCCESS (0.033s)
[267.911085] [152/162] (740s left) vgem_basic (sysfs)
[267.969787] Starting subtest: sysfs
[267.975932] Subtest sysfs: SUCCESS (0.000s)
[268.065622] [153/162] (739s left) core_hotunplug (unbind-rebind)
[268.148944] Starting subtest: unbind-rebind
[274.547322] Subtest unbind-rebind: SUCCESS (6.394s)
[274.651286] [154/162] (733s left) vgem_basic (unload)
[274.766260] Starting subtest: unload
[303.924888] Subtest unload: SUCCESS (29.158s)
[304.301759] [155/162] (704s left) i915_module_load (reload)
[304.446964] Starting subtest: reload
[310.228145] Subtest reload: SUCCESS (5.777s)
[310.317991] [156/162] (698s left) gem_lmem_swapping (basic)
[310.447577] Subtest basic: SKIP (0.000s)
[310.577666] [157/162] (698s left) gem_lmem_swapping (parallel-random-engines)
[310.718903] Subtest parallel-random-engines: SKIP (0.000s)
[310.830178] [158/162] (697s left) gem_lmem_swapping (random-engines)
[310.956773] Subtest random-engines: SKIP (0.000s)
[311.065490] [159/162] (697s left) gem_lmem_swapping (verify-random)
[311.186929] Subtest verify-random: SKIP (0.000s)
[311.302123] [160/162] (697s left) i915_pm_rpm (module-reload)
[313.587806] Starting subtest: module-reload
[333.576296] Subtest module-reload: SUCCESS (19.974s)
[333.646924] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[333.648506] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true
[333.666607] [161/162] (675s left) i915_selftest (live)