[64.801655] Initializing watchdogs
[64.801718]   /dev/watchdog0
[64.841946] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[64.854380] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[64.858639] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[64.861115] [001/130] (960s left) perf_pmu (gt-awake)
[64.929987] Starting subtest: gt-awake
[69.332800] Subtest gt-awake: SUCCESS (4.414s)
[69.531176] [002/130] (955s left) i915_getparams_basic (basic-eu-total)
[69.600203] Starting subtest: basic-eu-total
[69.602089] Subtest basic-eu-total: SUCCESS (0.000s)
[69.777967] [003/130] (955s left) kms_psr (fbc-psr2-sprite-plane-move)
[69.955717] Subtest fbc-psr2-sprite-plane-move: SKIP (0.000s)
[70.002383] [004/130] (955s left) kms_getfb (getfb2-accept-nv12)
[70.181092] Starting subtest: getfb2-accept-nv12
[70.182997] Subtest getfb2-accept-nv12: SUCCESS (0.002s)
[70.391947] [005/130] (955s left) syncobj_timeline (etime-single-wait-submitted)
[70.467337] Starting subtest: etime-single-wait-submitted
[70.576721] Subtest etime-single-wait-submitted: SUCCESS (0.107s)
[70.759479] [006/130] (954s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[70.942625] Starting subtest: fbcpsr-tiling-4
[70.944354] Subtest fbcpsr-tiling-4: SKIP (0.000s)
[71.124241] [007/130] (954s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[71.314493] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[71.316227] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[71.507660] [008/130] (954s left) gem_create (create-size-update)
[71.577987] Starting subtest: create-size-update
[71.578908] Subtest create-size-update: SUCCESS (0.000s)
[71.889981] [009/130] (954s left) gem_exec_nop (basic-parallel)
[71.968408] Starting subtest: basic-parallel
[76.355818] Subtest basic-parallel: SUCCESS (4.392s)
[76.680075] [010/130] (949s left) perf_pmu (rc6)
[76.740189] Starting subtest: rc6
[76.741151] Starting dynamic subtest: gt0
[83.113447] Dynamic subtest gt0: SUCCESS (6.362s)
[83.122123] Starting dynamic subtest: runtime-pm-gt0
[91.113897] Dynamic subtest runtime-pm-gt0: SUCCESS (8.009s)
[91.122650] Starting dynamic subtest: runtime-pm-long-gt0
[103.736744] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.621s)
[103.745355] Starting dynamic subtest: other-idle-gt0
[103.747179] Dynamic subtest other-idle-gt0: SKIP (0.000s)
[103.748099] Subtest rc6: SUCCESS (26.996s)
[104.462409] [011/130] (921s left) kms_cursor_crc (cursor-sliding-64x64)
[104.790584] Starting subtest: cursor-sliding-64x64
[104.807183] Starting dynamic subtest: pipe-A-DP-3
[109.285224] Dynamic subtest pipe-A-DP-3: SUCCESS (4.477s)
[109.334208] Starting dynamic subtest: pipe-D-DP-3
[113.734950] Dynamic subtest pipe-D-DP-3: SUCCESS (4.408s)
[113.736053] Subtest cursor-sliding-64x64: SUCCESS (8.943s)
[114.164098] [012/130] (912s left) perf (rc6-disable)
[114.487963] Starting subtest: rc6-disable
[114.684332] Subtest rc6-disable: SUCCESS (0.195s)
[114.776114] [013/130] (911s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[114.847905] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[114.951308] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.102s)
[115.006781] [014/130] (911s left) gem_workarounds (suspend-resume-fd)
[115.088697] Starting subtest: suspend-resume-fd
[134.666784] Subtest suspend-resume-fd: SUCCESS (3.880s)
[134.752408] [015/130] (891s left) gem_basic (create-close)
[134.823920] Starting subtest: create-close
[134.825723] Subtest create-close: SUCCESS (0.000s)
[134.899103] [016/130] (891s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[134.968930] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[135.077289] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.108s)
[135.185749] [017/130] (891s left) gen7_exec_parse (basic-allowed)
[135.264203] Subtest basic-allowed: SKIP (0.000s)
[135.327039] [018/130] (891s left) prime_busy (after-wait)
[135.401439] Starting subtest: after-wait
[135.406243] Starting dynamic subtest: rcs0
[135.453434] Dynamic subtest rcs0: SUCCESS (0.046s)
[135.464632] Starting dynamic subtest: bcs0
[135.525217] Dynamic subtest bcs0: SUCCESS (0.072s)
[135.539587] Starting dynamic subtest: vcs0
[135.565373] Dynamic subtest vcs0: SUCCESS (0.040s)
[135.580944] Starting dynamic subtest: vcs1
[135.606618] Dynamic subtest vcs1: SUCCESS (0.041s)
[135.635043] Starting dynamic subtest: vecs0
[135.651738] Dynamic subtest vecs0: SUCCESS (0.045s)
[135.680324] Starting dynamic subtest: vecs1
[135.692832] Dynamic subtest vecs1: SUCCESS (0.041s)
[135.707943] Starting dynamic subtest: ccs0
[135.735509] Dynamic subtest ccs0: SUCCESS (0.042s)
[135.849537] Subtest after-wait: SUCCESS (0.447s)
[135.997159] [019/130] (890s left) i915_query (engine-info-invalid)
[136.065139] Starting subtest: engine-info-invalid
[136.066058] Subtest engine-info-invalid: SUCCESS (0.000s)
[136.163513] [020/130] (890s left) kms_flip (2x-flip-vs-dpms-on-nop)
[136.343326] Starting subtest: 2x-flip-vs-dpms-on-nop
[136.358083] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.014s)
[136.413827] [021/130] (890s left) gem_eio (in-flight-internal-1us)
[136.736066] Starting subtest: in-flight-internal-1us
[137.621229] Subtest in-flight-internal-1us: SUCCESS (0.885s)
[137.798717] [022/130] (888s left) kms_psr2_su (page_flip-xrgb8888)
[137.869747] Subtest page_flip-XRGB8888: SKIP (0.000s)
[137.928161] [023/130] (888s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[138.006244] Starting subtest: x-tiled-to-vebox-yf-tiled
[138.008028] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[138.165206] [024/130] (888s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[138.348755] Starting subtest: yf-tiled-16bpp-rotate-270
[138.350667] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[138.442162] [025/130] (888s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[138.617262] Starting subtest: bad-pixel-format-y-tiled-ccs
[138.618199] Starting dynamic subtest: pipe-A-DP-3
[138.626681] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[138.637972] Starting dynamic subtest: pipe-B-DP-3
[138.646511] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[138.657572] Starting dynamic subtest: pipe-C-DP-3
[138.665885] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[138.677306] Starting dynamic subtest: pipe-D-DP-3
[138.687922] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[138.690125] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.004s)
[138.995494] [026/130] (887s left) gem_exec_params (dr1-dirt)
[139.067671] Starting subtest: DR1-dirt
[139.068630] Subtest DR1-dirt: SUCCESS (0.000s)
[139.146444] [027/130] (887s left) kms_color (legacy-gamma)
[139.323728] Starting subtest: legacy-gamma
[139.324673] Starting dynamic subtest: pipe-A-DP-3
[140.012146] Dynamic subtest pipe-A-DP-3: SUCCESS (0.687s)
[140.026797] Starting dynamic subtest: pipe-B-DP-3
[140.632016] Dynamic subtest pipe-B-DP-3: SUCCESS (0.620s)
[140.645298] Starting dynamic subtest: pipe-C-DP-3
[141.222318] Dynamic subtest pipe-C-DP-3: SUCCESS (0.590s)
[141.240539] Starting dynamic subtest: pipe-D-DP-3
[141.842965] Dynamic subtest pipe-D-DP-3: SUCCESS (0.621s)
[141.843972] Subtest legacy-gamma: SUCCESS (2.519s)
[142.033407] [028/130] (885s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[142.221265] Starting subtest: x-tiled-8bpp-rotate-0
[143.776614] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.555s)
[143.955977] [029/130] (883s left) prime_mmap (test_correct)
[144.028571] Starting subtest: test_correct
[144.040227] Starting dynamic subtest: test_correct-smem
[144.112387] Dynamic subtest test_correct-smem: SUCCESS (0.087s)
[144.124539] Starting dynamic subtest: test_correct-lmem0
[144.457829] Dynamic subtest test_correct-lmem0: SUCCESS (0.345s)
[144.458958] Subtest test_correct: SUCCESS (0.432s)
[144.518656] [030/130] (882s left) kms_pm_backlight (fade-with-suspend)
[144.694475] Subtest fade-with-suspend: SKIP (0.000s)
[144.751326] [031/130] (882s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[144.934661] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[144.983632] [032/130] (882s left) gem_ppgtt (blt-vs-render-ctx0)
[145.063395] Starting subtest: blt-vs-render-ctx0
[177.979917] Subtest blt-vs-render-ctx0: SUCCESS (32.915s)
[178.150467] [033/130] (849s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[178.398850] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[178.399709] Starting dynamic subtest: pipe-A-DP-3
[178.420953] Dynamic subtest pipe-A-DP-3: SKIP (0.002s)
[178.433049] Starting dynamic subtest: pipe-B-DP-3
[178.454243] Dynamic subtest pipe-B-DP-3: SKIP (0.002s)
[178.466435] Starting dynamic subtest: pipe-C-DP-3
[178.492507] Dynamic subtest pipe-C-DP-3: SKIP (0.002s)
[178.505040] Starting dynamic subtest: pipe-D-DP-3
[178.530238] Dynamic subtest pipe-D-DP-3: SKIP (0.002s)
[178.532294] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.012s)
[178.768767] [034/130] (848s left) gem_lmem_swapping (verify-random-ccs)
[181.510750] Starting subtest: verify-random-ccs
[181.511701] Starting dynamic subtest: lmem0
[188.472572] Dynamic subtest lmem0: SUCCESS (6.961s)
[188.473421] Subtest verify-random-ccs: SUCCESS (6.962s)
[189.552339] [FACT gem_lmem_swapping (verify-random-ccs)] deleted: kernel.kmod_is_loaded.i915: true
[189.554066] [035/130] (837s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[191.109791] Starting subtest: plane-primary-toggle-with-vblank-wait
[191.110699] Starting dynamic subtest: pipe-A-DP-3
[191.342374] Dynamic subtest pipe-A-DP-3: SUCCESS (0.231s)
[191.475633] Starting dynamic subtest: pipe-B-DP-3
[191.760282] Dynamic subtest pipe-B-DP-3: SUCCESS (0.303s)
[191.833203] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (0.724s)
[191.998463] [FACT kms_atomic_transition (plane-primary-toggle-with-vblank-wait)] new: kernel.kmod_is_loaded.i915: true
[192.001175] [036/130] (835s left) gem_exec_alignment (pi-isolated)
[192.086883] Starting subtest: pi-isolated
[209.139395] Subtest pi-isolated: SUCCESS (17.051s)
[209.594748] [037/130] (818s left) kms_pm_rpm (modeset-stress-extra-wait)
[211.780337] Starting subtest: modeset-stress-extra-wait
[264.255334] Subtest modeset-stress-extra-wait: SUCCESS (52.474s)
[264.348741] [038/130] (763s left) gem_exec_params (cliprects_ptr-dirt)
[264.425701] Starting subtest: cliprects_ptr-dirt
[264.426622] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[264.496236] [039/130] (763s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[264.678551] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[264.680199] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[264.746067] [040/130] (763s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[264.930760] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[264.931640] Starting dynamic subtest: pipe-A-DP-3
[264.940215] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[264.951893] Starting dynamic subtest: pipe-B-DP-3
[264.960340] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[264.971809] Starting dynamic subtest: pipe-C-DP-3
[264.980095] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[264.991721] Starting dynamic subtest: pipe-D-DP-3
[265.003145] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[265.005321] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.007s)
[265.319012] [041/130] (762s left) kms_busy (extended-modeset-hang-newfb)
[265.510371] Starting subtest: extended-modeset-hang-newfb
[265.512243] Starting dynamic subtest: pipe-A
[281.227768] Dynamic subtest pipe-A: SUCCESS (15.714s)
[281.250647] Starting dynamic subtest: pipe-D
[296.958470] Dynamic subtest pipe-D: SUCCESS (15.725s)
[296.959585] Subtest extended-modeset-hang-newfb: SUCCESS (31.447s)
[297.218131] [042/130] (730s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[297.406655] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[297.408275] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[297.472179] [043/130] (730s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[297.546884] Starting subtest: multi-wait-available-unsubmitted-signaled
[297.547791] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[297.640004] [044/130] (730s left) gem_softpin (evict-prime)
[297.721443] Starting subtest: evict-prime
[297.722282] Starting dynamic subtest: rcs0
[298.968145] Dynamic subtest rcs0: SUCCESS (1.246s)
[298.981935] Starting dynamic subtest: bcs0
[300.152118] Dynamic subtest bcs0: SUCCESS (1.183s)
[300.168295] Starting dynamic subtest: vcs0
[301.313199] Dynamic subtest vcs0: SUCCESS (1.160s)
[301.328076] Starting dynamic subtest: vcs1
[302.507225] Dynamic subtest vcs1: SUCCESS (1.193s)
[302.522296] Starting dynamic subtest: vecs0
[303.683359] Dynamic subtest vecs0: SUCCESS (1.175s)
[303.696040] Starting dynamic subtest: vecs1
[304.869215] Dynamic subtest vecs1: SUCCESS (1.185s)
[304.883599] Starting dynamic subtest: ccs0
[306.044268] Dynamic subtest ccs0: SUCCESS (1.174s)
[306.059371] Starting dynamic subtest: all
[307.226478] Dynamic subtest all: SUCCESS (1.181s)
[307.227538] Subtest evict-prime: SUCCESS (9.505s)
[307.304264] [045/130] (720s left) gem_exec_schedule (preempt-queue)
[307.384595] Subtest preempt-queue: SKIP (0.000s)
[307.737558] [046/130] (720s left) gem_userptr_blits (coherency-unsync)
[307.812621] Subtest coherency-unsync: SKIP (0.000s)
[307.945933] [047/130] (720s left) kms_cursor_legacy (single-move)
[308.122045] Starting subtest: single-move
[308.122934] Starting dynamic subtest: pipe-A
[313.501969] Dynamic subtest pipe-A: SUCCESS (5.380s)
[313.514822] Starting dynamic subtest: pipe-B
[318.881960] Dynamic subtest pipe-B: SUCCESS (5.379s)
[318.894335] Starting dynamic subtest: pipe-C
[324.261170] Dynamic subtest pipe-C: SUCCESS (5.378s)
[324.273695] Starting dynamic subtest: pipe-D
[329.640906] Dynamic subtest pipe-D: SUCCESS (5.379s)
[329.653291] Starting dynamic subtest: all-pipes
[335.021200] Dynamic subtest all-pipes: SUCCESS (5.380s)
[335.022070] Subtest single-move: SUCCESS (26.899s)
[335.075325] [048/130] (693s left) kms_vblank (query-forked-busy)
[335.254294] Starting subtest: query-forked-busy
[335.256230] Starting dynamic subtest: pipe-A-DP-3
[337.803277] Dynamic subtest pipe-A-DP-3: SUCCESS (2.547s)
[337.857796] Starting dynamic subtest: pipe-D-DP-3
[340.364372] Dynamic subtest pipe-D-DP-3: SUCCESS (2.548s)
[340.365767] Subtest query-forked-busy: SUCCESS (5.110s)
[340.610930] [049/130] (687s left) gem_pwrite (basic-exhaustion)
[340.682960] Subtest basic-exhaustion: SKIP (0.000s)
[340.764945] [050/130] (687s left) gem_userptr_blits (sync-unmap)
[340.845227] Starting subtest: sync-unmap
[340.867105] Subtest sync-unmap: SUCCESS (0.021s)
[340.977903] [051/130] (687s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[341.167245] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[342.348429] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (1.181s)
[342.538982] [052/130] (685s left) perf_pmu (busy-double-start)
[342.600724] Starting subtest: busy-double-start
[342.601717] Starting dynamic subtest: rcs0
[346.218982] Dynamic subtest rcs0: SUCCESS (3.617s)
[346.234914] Starting dynamic subtest: bcs0
[349.815006] Dynamic subtest bcs0: SUCCESS (3.593s)
[349.831796] Starting dynamic subtest: vcs0
[353.412917] Dynamic subtest vcs0: SUCCESS (3.595s)
[353.428949] Starting dynamic subtest: vcs1
[357.018241] Dynamic subtest vcs1: SUCCESS (3.602s)
[357.035001] Starting dynamic subtest: vecs0
[360.589928] Dynamic subtest vecs0: SUCCESS (3.569s)
[360.605941] Starting dynamic subtest: vecs1
[364.178947] Dynamic subtest vecs1: SUCCESS (3.586s)
[364.194633] Starting dynamic subtest: ccs0
[367.803020] Dynamic subtest ccs0: SUCCESS (3.621s)
[367.804821] Subtest busy-double-start: SUCCESS (25.203s)
[367.916852] [053/130] (660s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[367.989152] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[368.093135] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.103s)
[368.181807] [054/130] (660s left) gem_exec_fence (basic-wait)
[368.375983] Starting subtest: basic-wait
[368.376963] Starting dynamic subtest: rcs0
[368.488340] Dynamic subtest rcs0: SUCCESS (0.111s)
[368.536383] Starting dynamic subtest: bcs0
[368.547067] Dynamic subtest bcs0: SUCCESS (0.057s)
[368.564005] Starting dynamic subtest: vcs0
[368.600113] Dynamic subtest vcs0: SUCCESS (0.052s)
[368.616834] Starting dynamic subtest: vcs1
[368.651883] Dynamic subtest vcs1: SUCCESS (0.051s)
[368.682946] Starting dynamic subtest: vecs0
[368.709555] Dynamic subtest vecs0: SUCCESS (0.056s)
[368.734933] Starting dynamic subtest: vecs1
[368.765436] Dynamic subtest vecs1: SUCCESS (0.055s)
[368.789440] Starting dynamic subtest: ccs0
[368.819227] Dynamic subtest ccs0: SUCCESS (0.053s)
[368.820463] Subtest basic-wait: SUCCESS (0.444s)
[369.546744] [FACT gem_exec_fence (basic-wait)] new: kernel.kmod_is_loaded.vgem: true
[369.549162] [055/130] (659s left) kms_addfb_basic (addfb25-modifier-no-flag)
[369.745882] Starting subtest: addfb25-modifier-no-flag
[369.746725] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[369.815568] [056/130] (658s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[369.999061] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[369.999972] Starting dynamic subtest: pipe-A-DP-3
[370.021723] Dynamic subtest pipe-A-DP-3: SKIP (0.002s)
[370.034726] Starting dynamic subtest: pipe-B-DP-3
[370.056045] Dynamic subtest pipe-B-DP-3: SKIP (0.002s)
[370.068940] Starting dynamic subtest: pipe-C-DP-3
[370.094825] Dynamic subtest pipe-C-DP-3: SKIP (0.002s)
[370.108266] Starting dynamic subtest: pipe-D-DP-3
[370.131299] Dynamic subtest pipe-D-DP-3: SKIP (0.002s)
[370.133224] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.013s)
[370.379558] [057/130] (658s left) kms_fb_coherency (memset-crc)
[370.572884] Starting subtest: memset-crc
[370.573808] Starting dynamic subtest: mmap-offset-fixed
[371.166891] Dynamic subtest mmap-offset-fixed: CRASH (0.267s)
[371.496904] Subtest memset-crc: CRASH (0.590s)
[371.575946] [058/130] (657s left) gem_lmem_swapping (massive)
[374.168398] Starting subtest: massive
[374.169256] Starting dynamic subtest: lmem0
[384.565275] Dynamic subtest lmem0: SUCCESS (10.397s)
[384.566186] Subtest massive: SUCCESS (10.398s)
[386.025151] [FACT gem_lmem_swapping (massive)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[386.026122] [FACT gem_lmem_swapping (massive)] deleted: kernel.kmod_is_loaded.i915: true
[386.027816] [059/130] (642s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[387.774407] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[387.917316] [FACT kms_chamelium_hpd (hdmi-hpd-after-suspend)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[387.919645] [FACT kms_chamelium_hpd (hdmi-hpd-after-suspend)] new: kernel.kmod_is_loaded.i915: true
[387.922184] [060/130] (641s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[388.106554] Starting subtest: async-flip-with-page-flip-events-linear
[388.339541] Starting dynamic subtest: pipe-A-DP-3
[390.625794] Dynamic subtest pipe-A-DP-3: SUCCESS (2.285s)
[390.870711] Starting dynamic subtest: pipe-B-DP-3
[392.954465] Dynamic subtest pipe-B-DP-3: SUCCESS (2.095s)
[393.159342] Starting dynamic subtest: pipe-C-DP-3
[395.250628] Dynamic subtest pipe-C-DP-3: SUCCESS (2.103s)
[395.477030] Starting dynamic subtest: pipe-D-DP-3
[397.560412] Dynamic subtest pipe-D-DP-3: SUCCESS (2.094s)
[397.562564] Subtest async-flip-with-page-flip-events-linear: SUCCESS (9.454s)
[398.049616] [061/130] (631s left) gem_userptr_blits (stress-mm-invalidate-close-overlap)
[398.153318] Starting subtest: stress-mm-invalidate-close-overlap
[400.307257] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.148s)
[400.401746] [062/130] (628s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[400.595562] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[403.434388] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (2.840s)
[403.625145] [063/130] (625s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[403.814721] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[403.830241] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.015s)
[403.898248] [064/130] (625s left) kms_flip (plain-flip-fb-recreate-interruptible)
[404.089423] Starting subtest: plain-flip-fb-recreate-interruptible
[404.094210] Starting dynamic subtest: A-DP3
[412.180689] Dynamic subtest A-DP3: SUCCESS (8.086s)
[412.226282] Starting dynamic subtest: B-DP3
[420.244909] Dynamic subtest B-DP3: SUCCESS (8.059s)
[420.281968] Starting dynamic subtest: C-DP3
[428.284763] Dynamic subtest C-DP3: SUCCESS (8.035s)
[428.328022] Starting dynamic subtest: D-DP3
[436.345888] Dynamic subtest D-DP3: SUCCESS (8.056s)
[436.354231] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (32.264s)
[436.665802] [065/130] (592s left) gem_exec_fence (syncobj-repeat)
[437.174553] Starting subtest: syncobj-repeat
[437.493026] Subtest syncobj-repeat: SUCCESS (0.319s)
[437.907489] [066/130] (591s left) i915_query (query-topology-coherent-slice-mask)
[437.985346] Starting subtest: query-topology-coherent-slice-mask
[437.987229] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[438.100454] [067/130] (591s left) kms_cursor_crc (cursor-onscreen-512x512)
[438.558940] Starting subtest: cursor-onscreen-512x512
[438.560755] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[438.765570] [068/130] (590s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[438.956895] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[438.958676] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[439.024220] [069/130] (590s left) kms_plane_scaling (invalid-num-scalers)
[439.211940] Starting subtest: invalid-num-scalers
[439.218532] Starting dynamic subtest: pipe-A-DP-3-invalid-num-scalers
[439.240138] Dynamic subtest pipe-A-DP-3-invalid-num-scalers: SUCCESS (0.021s)
[439.258346] Starting dynamic subtest: pipe-B-DP-3-invalid-num-scalers
[439.284268] Dynamic subtest pipe-B-DP-3-invalid-num-scalers: SUCCESS (0.037s)
[439.302702] Starting dynamic subtest: pipe-C-DP-3-invalid-num-scalers
[439.329603] Dynamic subtest pipe-C-DP-3-invalid-num-scalers: SUCCESS (0.037s)
[439.347239] Starting dynamic subtest: pipe-D-DP-3-invalid-num-scalers
[439.373326] Dynamic subtest pipe-D-DP-3-invalid-num-scalers: SUCCESS (0.037s)
[439.374128] Subtest invalid-num-scalers: SUCCESS (0.163s)
[439.472657] [070/130] (590s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[439.551196] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[439.634054] [071/130] (590s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[441.757250] Starting subtest: gem-execbuf-stress-pc8
[441.879164] Subtest gem-execbuf-stress-pc8: SKIP (0.122s)
[442.032375] [072/130] (587s left) syncobj_timeline (wait-any-interrupted)
[442.113301] Starting subtest: wait-any-interrupted
[442.216301] Subtest wait-any-interrupted: SUCCESS (0.102s)
[442.333848] [073/130] (587s left) sw_sync (sync_merge_same)
[442.382019] Starting subtest: sync_merge_same
[442.382943] Subtest sync_merge_same: SUCCESS (0.000s)
[442.433701] [074/130] (587s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[442.627677] Starting subtest: psr-2p-pri-indfb-multidraw
[442.629417] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[442.707286] [075/130] (587s left) kms_hdr (bpc-switch-suspend)
[442.903195] Starting subtest: bpc-switch-suspend
[446.195068] Starting dynamic subtest: pipe-A-DP-3
[466.325009] Dynamic subtest pipe-A-DP-3: SUCCESS (4.997s)
[466.329286] Subtest bpc-switch-suspend: SUCCESS (8.292s)
[466.638918] [076/130] (563s left) api_intel_bb (blit-noreloc-keep-cache)
[466.724936] Starting subtest: blit-noreloc-keep-cache
[466.759806] Subtest blit-noreloc-keep-cache: SUCCESS (0.036s)
[466.874122] [077/130] (563s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[467.064214] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[467.065800] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[467.136082] [078/130] (562s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[467.322612] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[467.323515] Starting dynamic subtest: pipe-A-valid-mode
[467.398238] Dynamic subtest pipe-A-valid-mode: SKIP (0.074s)
[467.399933] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.076s)
[467.543380] [079/130] (562s left) kms_chamelium_frames (hdmi-crc-fast)
[467.816669] Subtest hdmi-crc-fast: SKIP (0.000s)
[467.973227] [080/130] (562s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[468.160252] Starting subtest: primary-4-tiled-reflect-x-0
[478.414987] Subtest primary-4-tiled-reflect-x-0: SUCCESS (10.254s)
[478.762432] [081/130] (551s left) sw_sync (sync_merge)
[478.810304] Starting subtest: sync_merge
[478.811269] Subtest sync_merge: SUCCESS (0.000s)
[478.861418] [082/130] (551s left) gem_ctx_persistence (engines-mixed-process)
[478.947263] Starting subtest: engines-mixed-process
[478.948227] Starting dynamic subtest: rcs0
[480.698497] Dynamic subtest rcs0: SUCCESS (1.751s)
[480.716576] Starting dynamic subtest: bcs0
[482.732354] Dynamic subtest bcs0: SUCCESS (2.032s)
[482.748560] Starting dynamic subtest: vcs0
[484.712871] Dynamic subtest vcs0: SUCCESS (1.979s)
[484.730003] Starting dynamic subtest: vcs1
[486.706701] Dynamic subtest vcs1: SUCCESS (1.992s)
[486.722719] Starting dynamic subtest: vecs0
[488.747069] Dynamic subtest vecs0: SUCCESS (2.039s)
[488.763178] Starting dynamic subtest: vecs1
[490.731114] Dynamic subtest vecs1: SUCCESS (1.983s)
[490.747474] Starting dynamic subtest: ccs0
[492.724291] Dynamic subtest ccs0: SUCCESS (1.990s)
[492.725466] Subtest engines-mixed-process: SUCCESS (13.776s)
[492.797144] [083/130] (537s left) gem_exec_parallel (userptr)
[492.885692] Starting subtest: userptr
[492.886640] Starting dynamic subtest: rcs0
[494.405782] Dynamic subtest rcs0: SUCCESS (1.519s)
[494.423874] Starting dynamic subtest: bcs0
[495.867707] Dynamic subtest bcs0: SUCCESS (1.461s)
[495.885668] Starting dynamic subtest: vcs0
[497.366856] Dynamic subtest vcs0: SUCCESS (1.498s)
[497.384158] Starting dynamic subtest: vcs1
[498.871823] Dynamic subtest vcs1: SUCCESS (1.504s)
[498.888286] Starting dynamic subtest: vecs0
[500.335697] Dynamic subtest vecs0: SUCCESS (1.463s)
[500.354342] Starting dynamic subtest: vecs1
[501.800127] Dynamic subtest vecs1: SUCCESS (1.463s)
[501.818753] Starting dynamic subtest: ccs0
[503.275975] Dynamic subtest ccs0: SUCCESS (1.474s)
[503.277013] Subtest userptr: SUCCESS (10.391s)
[503.540165] [084/130] (526s left) kms_flip (absolute-wf_vblank-interruptible)
[503.734538] Starting subtest: absolute-wf_vblank-interruptible
[503.739386] Starting dynamic subtest: A-DP3
[511.544416] Dynamic subtest A-DP3: SUCCESS (7.804s)
[511.563146] Starting dynamic subtest: B-DP3
[519.284037] Dynamic subtest B-DP3: SUCCESS (7.735s)
[519.300458] Starting dynamic subtest: C-DP3
[527.036089] Dynamic subtest C-DP3: SUCCESS (7.750s)
[527.052403] Starting dynamic subtest: D-DP3
[534.784166] Dynamic subtest D-DP3: SUCCESS (7.746s)
[534.786624] Subtest absolute-wf_vblank-interruptible: SUCCESS (31.051s)
[535.089219] [085/130] (495s left) kms_force_connector_basic (prune-stale-modes)
[535.194961] Starting subtest: prune-stale-modes
[535.219046] Subtest prune-stale-modes: SUCCESS (0.024s)
[535.498627] [086/130] (495s left) gem_ctx_persistence (processes)
[535.583805] Starting subtest: processes
[536.739646] Subtest processes: SUCCESS (1.156s)
[536.798667] [087/130] (493s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[536.987685] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[536.989358] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[537.091896] [088/130] (493s left) gem_exec_flush (basic-uc-ro-default)
[537.173742] Subtest basic-uc-ro-default: SKIP (0.000s)
[537.246719] [089/130] (493s left) kms_psr (pr-dpms)
[537.430884] Subtest pr-dpms: SKIP (0.000s)
[537.496807] [090/130] (493s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[537.694500] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[537.696266] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[537.812296] [091/130] (493s left) kms_lease (lease-invalid-crtc)
[538.001731] Starting subtest: lease-invalid-crtc
[538.002610] Starting dynamic subtest: pipe-A-DP-3
[538.003486] Dynamic subtest pipe-A-DP-3: SUCCESS (0.000s)
[538.017529] Starting dynamic subtest: pipe-B-DP-3
[538.018769] Dynamic subtest pipe-B-DP-3: SUCCESS (0.000s)
[538.032761] Starting dynamic subtest: pipe-C-DP-3
[538.033950] Dynamic subtest pipe-C-DP-3: SUCCESS (0.000s)
[538.047838] Starting dynamic subtest: pipe-D-DP-3
[538.049062] Dynamic subtest pipe-D-DP-3: SUCCESS (0.000s)
[538.050197] Subtest lease-invalid-crtc: SUCCESS (0.007s)
[538.099789] [092/130] (492s left) i915_query (query-topology-unsupported)
[538.178666] Starting subtest: query-topology-unsupported
[538.180502] Subtest query-topology-unsupported: SKIP (0.000s)
[538.278708] [093/130] (492s left) prime_self_import (export-vs-gem_close-race)
[538.326532] Starting subtest: export-vs-gem_close-race
[543.420596] Subtest export-vs-gem_close-race: SUCCESS (5.094s)
[543.491669] [094/130] (487s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[543.701480] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[547.854937] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: FAIL (3.806s)
[547.936207] [095/130] (483s left) gem_exec_reloc (basic-cpu-active)
[548.020732] Subtest basic-cpu-active: SKIP (0.000s)
[548.118738] [096/130] (483s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[548.310448] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[548.312116] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[548.383274] [097/130] (482s left) syncobj_timeline (invalid-transfer-non-existent-point)
[548.463699] Starting subtest: invalid-transfer-non-existent-point
[548.464635] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[548.558216] [098/130] (482s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[548.750757] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[548.752479] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[548.832392] [099/130] (482s left) kms_vblank (query-idle-hang)
[549.019745] Starting subtest: query-idle-hang
[549.020621] Starting dynamic subtest: pipe-A-DP-3
[575.408001] Dynamic subtest pipe-A-DP-3: SUCCESS (26.387s)
[575.425470] Starting dynamic subtest: pipe-D-DP-3
[600.418992] Dynamic subtest pipe-D-DP-3: SUCCESS (25.007s)
[600.421381] Subtest query-idle-hang: SUCCESS (51.401s)
[600.625339] [100/130] (430s left) i915_drm_fdinfo (busy-idle)
[600.696684] Starting subtest: busy-idle
[600.697922] Starting dynamic subtest: rcs0
[600.721544] Dynamic subtest rcs0: SKIP (0.025s)
[600.736186] Starting dynamic subtest: bcs0
[600.738452] Dynamic subtest bcs0: SKIP (0.000s)
[600.752868] Starting dynamic subtest: vcs0
[600.755245] Dynamic subtest vcs0: SKIP (0.000s)
[600.769713] Starting dynamic subtest: vcs1
[600.771700] Dynamic subtest vcs1: SKIP (0.000s)
[600.785348] Starting dynamic subtest: vecs0
[600.787022] Dynamic subtest vecs0: SKIP (0.000s)
[600.800967] Starting dynamic subtest: vecs1
[600.803349] Dynamic subtest vecs1: SKIP (0.000s)
[600.817199] Starting dynamic subtest: ccs0
[600.819652] Dynamic subtest ccs0: SKIP (0.000s)
[600.821903] Subtest busy-idle: SKIP (0.034s)
[600.870708] [101/130] (430s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[601.064230] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[604.061668] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (2.998s)
[604.194898] [102/130] (427s left) kms_psr (psr-primary-mmap-cpu)
[604.379789] Subtest psr-primary-mmap-cpu: SKIP (0.000s)
[604.442449] [103/130] (427s left) kms_pm_rpm (dpms-non-lpsp)
[606.859795] Starting subtest: dpms-non-lpsp
[607.058246] Subtest dpms-non-lpsp: SUCCESS (0.199s)
[607.252887] [104/130] (424s left) device_reset (unbind-reset-rebind)
[607.339931] Starting subtest: unbind-reset-rebind
[609.753828] Subtest unbind-reset-rebind: SUCCESS (2.415s)
[609.818720] [105/130] (421s left) kms_pipe_crc_basic (read-crc)
[610.006182] Starting subtest: read-crc
[610.008598] Starting dynamic subtest: pipe-A-DP-3
[610.693068] Dynamic subtest pipe-A-DP-3: SUCCESS (0.685s)
[610.712004] Starting dynamic subtest: pipe-B-DP-3
[611.263199] Dynamic subtest pipe-B-DP-3: SUCCESS (0.567s)
[611.284983] Starting dynamic subtest: pipe-C-DP-3
[611.869783] Dynamic subtest pipe-C-DP-3: SUCCESS (0.603s)
[611.898866] Starting dynamic subtest: pipe-D-DP-3
[612.476496] Dynamic subtest pipe-D-DP-3: SUCCESS (0.601s)
[612.477444] Subtest read-crc: SUCCESS (2.470s)
[612.679881] [106/130] (419s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[612.869871] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[612.871574] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[612.961992] [107/130] (418s left) kms_async_flips (test-time-stamp)
[613.144604] Starting subtest: test-time-stamp
[613.374795] Starting dynamic subtest: pipe-A-DP-3
[613.694374] Dynamic subtest pipe-A-DP-3: SUCCESS (0.318s)
[613.941090] Starting dynamic subtest: pipe-B-DP-3
[614.071425] Dynamic subtest pipe-B-DP-3: SUCCESS (0.142s)
[614.302909] Starting dynamic subtest: pipe-C-DP-3
[614.442572] Dynamic subtest pipe-C-DP-3: SUCCESS (0.152s)
[614.691471] Starting dynamic subtest: pipe-D-DP-3
[614.818041] Dynamic subtest pipe-D-DP-3: SUCCESS (0.141s)
[614.819669] Subtest test-time-stamp: SUCCESS (1.674s)
[615.252777] [108/130] (416s left) api_intel_bb (reset-bb)
[615.329906] Starting subtest: reset-bb
[615.357392] Subtest reset-bb: SUCCESS (0.029s)
[615.476473] [109/130] (416s left) gem_exec_whisper (basic-normal-all)
[615.570742] Starting subtest: basic-normal-all
[617.813804] Subtest basic-normal-all: SUCCESS (2.242s)
[618.041764] [110/130] (414s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[618.245792] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[618.309568] [111/130] (413s left) fbdev (eof)
[618.368375] Starting subtest: eof
[618.369509] Subtest eof: SUCCESS (0.001s)
[618.439413] [112/130] (413s left) kms_psr (pr-cursor-blt)
[618.629489] Subtest pr-cursor-blt: SKIP (0.000s)
[618.693570] [113/130] (413s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[618.776107] Starting subtest: y-tiled-to-vebox-yf-tiled
[618.778403] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[618.957828] [114/130] (413s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[619.151275] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[619.152914] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[619.228263] [115/130] (413s left) kms_plane (pixel-format-source-clamping)
[619.413906] Starting subtest: pixel-format-source-clamping
[619.443828] Starting dynamic subtest: pipe-A-plane-0
[626.961024] Dynamic subtest pipe-A-plane-0: SUCCESS (7.517s)
[626.979947] Starting dynamic subtest: pipe-A-plane-3
[630.760643] Dynamic subtest pipe-A-plane-3: SUCCESS (3.797s)
[630.777442] Starting dynamic subtest: pipe-A-plane-5
[630.778427] Dynamic subtest pipe-A-plane-5: SUCCESS (0.000s)
[630.998865] Starting dynamic subtest: pipe-B-plane-0
[638.009845] Dynamic subtest pipe-B-plane-0: SUCCESS (7.033s)
[638.025589] Starting dynamic subtest: pipe-B-plane-3
[642.026559] Dynamic subtest pipe-B-plane-3: SUCCESS (4.016s)
[642.046659] Starting dynamic subtest: pipe-B-plane-5
[642.047648] Dynamic subtest pipe-B-plane-5: SUCCESS (0.000s)
[642.117472] Subtest pixel-format-source-clamping: SUCCESS (22.702s)
[642.377986] [116/130] (390s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[642.572556] Starting subtest: 4-tiled-addfb-size-offset-overflow
[642.573508] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.001s)
[642.660437] [117/130] (389s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[642.848744] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[642.849615] Starting dynamic subtest: pipe-A-valid-mode
[645.260831] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.409s)
[645.262433] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SUCCESS (2.413s)
[645.478635] [118/130] (387s left) gem_mmap_offset (oob-read)
[645.560637] Starting subtest: oob-read
[645.561526] Subtest oob-read: SUCCESS (0.000s)
[645.636710] [119/130] (386s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[645.833560] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[645.835276] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[645.928188] [120/130] (386s left) kms_chamelium_color (ctm-blue-to-red)
[646.115538] Subtest ctm-blue-to-red: SKIP (0.000s)
[646.186567] [121/130] (386s left) gem_eio (wait-immediate)
[646.463309] Starting subtest: wait-immediate
[647.124496] Subtest wait-immediate: SUCCESS (0.662s)
[647.305665] [122/130] (385s left) gem_exec_suspend (basic-s3-devices)
[647.389959] Starting subtest: basic-S3-devices
[647.390855] Starting dynamic subtest: smem
[657.581620] Dynamic subtest smem: SUCCESS (10.191s)
[657.596737] Starting dynamic subtest: lmem0
[667.733762] Dynamic subtest lmem0: SUCCESS (10.151s)
[667.734820] Subtest basic-S3-devices: SUCCESS (20.344s)
[667.981108] [123/130] (364s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[668.060751] Starting subtest: invalid-multi-wait-unsubmitted
[668.061750] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[668.160387] [124/130] (364s left) gem_exec_balancer (full-late-pulse)
[668.245946] Starting subtest: full-late-pulse
[670.291567] Subtest full-late-pulse: SUCCESS (2.046s)
[670.648698] [125/130] (362s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[670.839585] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[670.841273] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[670.915703] [126/130] (362s left) syncobj_wait (single-wait-for-submit-submitted)
[670.992777] Starting subtest: single-wait-for-submit-submitted
[671.097660] Subtest single-wait-for-submit-submitted: SUCCESS (0.104s)
[671.213661] [127/130] (361s left) gem_exec_schedule (semaphore-resolve)
[671.301747] Starting subtest: semaphore-resolve
[671.381691] Subtest semaphore-resolve: SUCCESS (0.080s)
[671.781288] [128/130] (361s left) syncobj_basic (bad-pad-handle-to-fd)
[671.862822] Starting subtest: bad-pad-handle-to-fd
[671.863719] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[671.952885] [129/130] (361s left) gen7_exec_parse (chained-batch)
[672.037120] Subtest chained-batch: SKIP (0.000s)
[672.118539] [130/130] (361s left) kms_cursor_crc (cursor-onscreen-256x256)
[672.527190] Starting subtest: cursor-onscreen-256x256
[672.532347] Starting dynamic subtest: pipe-A-DP-3
[675.093750] Dynamic subtest pipe-A-DP-3: SUCCESS (2.561s)
[675.145714] Starting dynamic subtest: pipe-D-DP-3
[677.891783] Dynamic subtest pipe-D-DP-3: SUCCESS (2.760s)
[677.892774] Subtest cursor-onscreen-256x256: SUCCESS (5.365s)
[678.209665] Closing watchdogs
results: parsing output: 0/ for test: perf_pmu
results: parsing output: 1/ for test: i915_getparams_basic
results: parsing output: 2/ for test: kms_psr
results: parsing output: 3/ for test: kms_getfb
results: parsing output: 4/ for test: syncobj_timeline
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: gem_create
results: parsing output: 8/ for test: gem_exec_nop
results: parsing output: 9/ for test: perf_pmu
results: parsing output: 10/ for test: kms_cursor_crc
results: parsing output: 11/ for test: perf
results: parsing output: 12/ for test: syncobj_timeline
results: parsing output: 13/ for test: gem_workarounds
results: parsing output: 14/ for test: gem_basic
results: parsing output: 15/ for test: syncobj_wait
results: parsing output: 16/ for test: gen7_exec_parse
results: parsing output: 17/ for test: prime_busy
results: parsing output: 18/ for test: i915_query
results: parsing output: 19/ for test: kms_flip
results: parsing output: 20/ for test: gem_eio
results: parsing output: 21/ for test: kms_psr2_su
results: parsing output: 22/ for test: gem_render_copy
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: gem_exec_params
results: parsing output: 26/ for test: kms_color
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: prime_mmap
results: parsing output: 29/ for test: kms_pm_backlight
results: parsing output: 30/ for test: kms_psr2_sf
results: parsing output: 31/ for test: gem_ppgtt
results: parsing output: 32/ for test: kms_ccs
results: parsing output: 33/ for test: gem_lmem_swapping
results: parsing output: 34/ for test: kms_atomic_transition
results: parsing output: 35/ for test: gem_exec_alignment
results: parsing output: 36/ for test: kms_pm_rpm
results: parsing output: 37/ for test: gem_exec_params
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_ccs
results: parsing output: 40/ for test: kms_busy
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: gem_softpin
results: parsing output: 44/ for test: gem_exec_schedule
results: parsing output: 45/ for test: gem_userptr_blits
results: parsing output: 46/ for test: kms_cursor_legacy
results: parsing output: 47/ for test: kms_vblank
results: parsing output: 48/ for test: gem_pwrite
results: parsing output: 49/ for test: gem_userptr_blits
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: perf_pmu
results: parsing output: 52/ for test: syncobj_wait
results: parsing output: 53/ for test: gem_exec_fence
results: parsing output: 54/ for test: kms_addfb_basic
results: parsing output: 55/ for test: kms_ccs
results: parsing output: 56/ for test: kms_fb_coherency
results: parsing output: 57/ for test: gem_lmem_swapping
results: parsing output: 58/ for test: kms_chamelium_hpd
results: parsing output: 59/ for test: kms_async_flips
results: parsing output: 60/ for test: gem_userptr_blits
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_flip
results: parsing output: 63/ for test: kms_flip
results: parsing output: 64/ for test: gem_exec_fence
results: parsing output: 65/ for test: i915_query
results: parsing output: 66/ for test: kms_cursor_crc
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_plane_scaling
results: parsing output: 69/ for test: kms_pipe_b_c_ivb
results: parsing output: 70/ for test: i915_pm_rpm
results: parsing output: 71/ for test: syncobj_timeline
results: parsing output: 72/ for test: sw_sync
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_hdr
results: parsing output: 75/ for test: api_intel_bb
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_flip_scaled_crc
results: parsing output: 78/ for test: kms_chamelium_frames
results: parsing output: 79/ for test: kms_rotation_crc
results: parsing output: 80/ for test: sw_sync
results: parsing output: 81/ for test: gem_ctx_persistence
results: parsing output: 82/ for test: gem_exec_parallel
results: parsing output: 83/ for test: kms_flip
results: parsing output: 84/ for test: kms_force_connector_basic
results: parsing output: 85/ for test: gem_ctx_persistence
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_exec_flush
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_lease
results: parsing output: 91/ for test: i915_query
results: parsing output: 92/ for test: prime_self_import
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: gem_exec_reloc
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: syncobj_timeline
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: kms_vblank
results: parsing output: 99/ for test: i915_drm_fdinfo
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: kms_pm_rpm
results: parsing output: 103/ for test: device_reset
results: parsing output: 104/ for test: kms_pipe_crc_basic
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_async_flips
results: parsing output: 107/ for test: api_intel_bb
results: parsing output: 108/ for test: gem_exec_whisper
results: parsing output: 109/ for test: kms_psr2_sf
results: parsing output: 110/ for test: fbdev
results: parsing output: 111/ for test: kms_psr
results: parsing output: 112/ for test: gem_render_copy
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_plane
results: parsing output: 115/ for test: kms_big_fb
results: parsing output: 116/ for test: kms_flip_scaled_crc
results: parsing output: 117/ for test: gem_mmap_offset
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_chamelium_color
results: parsing output: 120/ for test: gem_eio
results: parsing output: 121/ for test: gem_exec_suspend
results: parsing output: 122/ for test: syncobj_wait
results: parsing output: 123/ for test: gem_exec_balancer
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: syncobj_wait
results: parsing output: 126/ for test: gem_exec_schedule
results: parsing output: 127/ for test: syncobj_basic
results: parsing output: 128/ for test: gen7_exec_parse
results: parsing output: 129/ for test: kms_cursor_crc
Done.