[67.383359] Initializing watchdogs
[67.383473]   /dev/watchdog0
[67.422434] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[67.449974] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[67.456720] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[67.459982] [001/130] (960s left) perf_pmu (gt-awake)
[67.586619] Starting subtest: gt-awake
[71.986576] Subtest gt-awake: SUCCESS (4.398s)
[72.168293] [002/130] (955s left) i915_getparams_basic (basic-eu-total)
[72.236162] Starting subtest: basic-eu-total
[72.237954] Subtest basic-eu-total: SUCCESS (0.000s)
[72.420625] [003/130] (955s left) kms_psr (fbc-psr2-sprite-plane-move)
[72.610348] Subtest fbc-psr2-sprite-plane-move: SKIP (0.000s)
[72.663317] [004/130] (955s left) kms_getfb (getfb2-accept-nv12)
[72.842968] Starting subtest: getfb2-accept-nv12
[72.843962] Subtest getfb2-accept-nv12: SUCCESS (0.002s)
[73.069222] [005/130] (955s left) syncobj_timeline (etime-single-wait-submitted)
[73.140299] Starting subtest: etime-single-wait-submitted
[73.246767] Subtest etime-single-wait-submitted: SUCCESS (0.106s)
[73.419877] [006/130] (954s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[73.601420] Starting subtest: fbcpsr-tiling-4
[73.603111] Subtest fbcpsr-tiling-4: SKIP (0.000s)
[73.804397] [007/130] (954s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[73.997173] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[73.999008] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[74.187620] [008/130] (954s left) gem_create (create-size-update)
[74.252970] Starting subtest: create-size-update
[74.253910] Subtest create-size-update: SUCCESS (0.000s)
[74.525798] [009/130] (954s left) gem_exec_nop (basic-parallel)
[74.614270] Starting subtest: basic-parallel
[78.999102] Subtest basic-parallel: SUCCESS (4.384s)
[79.333939] [010/130] (949s left) perf_pmu (rc6)
[79.395205] Starting subtest: rc6
[79.396144] Starting dynamic subtest: gt0
[85.747240] Dynamic subtest gt0: SUCCESS (6.349s)
[85.756597] Starting dynamic subtest: runtime-pm-gt0
[93.747650] Dynamic subtest runtime-pm-gt0: SUCCESS (7.998s)
[93.756218] Starting dynamic subtest: runtime-pm-long-gt0
[106.369704] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.620s)
[106.378295] Starting dynamic subtest: other-idle-gt0
[106.380146] Dynamic subtest other-idle-gt0: SKIP (0.000s)
[106.381057] Subtest rc6: SUCCESS (26.971s)
[107.056303] [011/130] (921s left) kms_cursor_crc (cursor-sliding-64x64)
[107.382207] Starting subtest: cursor-sliding-64x64
[107.397035] Starting dynamic subtest: pipe-A-DP-3
[111.733550] Dynamic subtest pipe-A-DP-3: SUCCESS (4.335s)
[111.781266] Starting dynamic subtest: pipe-D-DP-3
[115.914312] Dynamic subtest pipe-D-DP-3: SUCCESS (4.141s)
[115.915365] Subtest cursor-sliding-64x64: SUCCESS (8.531s)
[116.338843] [012/130] (912s left) perf (rc6-disable)
[116.664083] Starting subtest: rc6-disable
[116.845909] Subtest rc6-disable: SUCCESS (0.182s)
[116.960051] [013/130] (911s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[117.029937] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[117.134543] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.104s)
[117.240538] [014/130] (911s left) gem_workarounds (suspend-resume-fd)
[117.328185] Starting subtest: suspend-resume-fd
[136.684905] Subtest suspend-resume-fd: SUCCESS (3.889s)
[136.768986] [015/130] (892s left) gem_basic (create-close)
[136.838659] Starting subtest: create-close
[136.840641] Subtest create-close: SUCCESS (0.000s)
[136.967663] [016/130] (892s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[137.039971] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[137.146303] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.105s)
[137.249027] [017/130] (891s left) gen7_exec_parse (basic-allowed)
[137.322003] Subtest basic-allowed: SKIP (0.000s)
[137.394060] [018/130] (891s left) prime_busy (after-wait)
[137.483246] Starting subtest: after-wait
[137.488679] Starting dynamic subtest: rcs0
[137.559689] Dynamic subtest rcs0: SUCCESS (0.071s)
[137.570519] Starting dynamic subtest: bcs0
[137.614569] Dynamic subtest bcs0: SUCCESS (0.055s)
[137.635289] Starting dynamic subtest: vcs0
[137.659470] Dynamic subtest vcs0: SUCCESS (0.044s)
[137.690720] Starting dynamic subtest: vcs1
[137.699513] Dynamic subtest vcs1: SUCCESS (0.040s)
[137.718461] Starting dynamic subtest: vecs0
[137.740170] Dynamic subtest vecs0: SUCCESS (0.040s)
[137.753855] Starting dynamic subtest: vecs1
[137.782270] Dynamic subtest vecs1: SUCCESS (0.042s)
[137.798707] Starting dynamic subtest: ccs0
[137.826476] Dynamic subtest ccs0: SUCCESS (0.044s)
[137.940052] Subtest after-wait: SUCCESS (0.456s)
[138.095706] [019/130] (891s left) i915_query (engine-info-invalid)
[138.164941] Starting subtest: engine-info-invalid
[138.165914] Subtest engine-info-invalid: SUCCESS (0.000s)
[138.298346] [020/130] (891s left) kms_flip (2x-flip-vs-dpms-on-nop)
[138.481943] Starting subtest: 2x-flip-vs-dpms-on-nop
[138.496949] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.015s)
[138.563447] [021/130] (890s left) gem_eio (in-flight-internal-1us)
[138.863298] Starting subtest: in-flight-internal-1us
[140.333149] Subtest in-flight-internal-1us: SUCCESS (1.470s)
[140.498041] [022/130] (888s left) kms_psr2_su (page_flip-xrgb8888)
[140.569772] Subtest page_flip-XRGB8888: SKIP (0.000s)
[140.627913] [023/130] (888s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[140.706220] Starting subtest: x-tiled-to-vebox-yf-tiled
[140.708385] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[140.863733] [024/130] (888s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[141.049944] Starting subtest: yf-tiled-16bpp-rotate-270
[141.051862] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[141.135419] [025/130] (888s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[141.308976] Starting subtest: bad-pixel-format-y-tiled-ccs
[141.309918] Starting dynamic subtest: pipe-A-DP-3
[141.318650] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[141.330104] Starting dynamic subtest: pipe-B-DP-3
[141.338247] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[141.349326] Starting dynamic subtest: pipe-C-DP-3
[141.357512] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[141.368693] Starting dynamic subtest: pipe-D-DP-3
[141.380670] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[141.382909] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.004s)
[141.702149] [026/130] (887s left) gem_exec_params (dr1-dirt)
[141.775975] Starting subtest: DR1-dirt
[141.776951] Subtest DR1-dirt: SUCCESS (0.000s)
[141.861369] [027/130] (887s left) kms_color (legacy-gamma)
[142.041754] Starting subtest: legacy-gamma
[142.042677] Starting dynamic subtest: pipe-A-DP-3
[142.726332] Dynamic subtest pipe-A-DP-3: SUCCESS (0.684s)
[142.745617] Starting dynamic subtest: pipe-B-DP-3
[143.320183] Dynamic subtest pipe-B-DP-3: SUCCESS (0.593s)
[143.333549] Starting dynamic subtest: pipe-C-DP-3
[143.892119] Dynamic subtest pipe-C-DP-3: SUCCESS (0.572s)
[143.905167] Starting dynamic subtest: pipe-D-DP-3
[144.505440] Dynamic subtest pipe-D-DP-3: SUCCESS (0.613s)
[144.506463] Subtest legacy-gamma: SUCCESS (2.464s)
[144.714635] [028/130] (885s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[144.903083] Starting subtest: x-tiled-8bpp-rotate-0
[146.510448] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.607s)
[146.723385] [029/130] (883s left) prime_mmap (test_correct)
[146.801347] Starting subtest: test_correct
[146.802272] Starting dynamic subtest: test_correct-smem
[146.853732] Dynamic subtest test_correct-smem: SUCCESS (0.052s)
[146.865355] Starting dynamic subtest: test_correct-lmem0
[147.042829] Dynamic subtest test_correct-lmem0: SUCCESS (0.188s)
[147.043709] Subtest test_correct: SUCCESS (0.241s)
[147.119835] [030/130] (882s left) kms_pm_backlight (fade-with-suspend)
[147.294122] Subtest fade-with-suspend: SKIP (0.000s)
[147.351388] [031/130] (882s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[147.541935] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[147.601029] [032/130] (882s left) gem_ppgtt (blt-vs-render-ctx0)
[147.674101] Starting subtest: blt-vs-render-ctx0
[180.488244] Subtest blt-vs-render-ctx0: SUCCESS (32.814s)
[180.658518] [033/130] (849s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[180.897551] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[180.898392] Starting dynamic subtest: pipe-A-DP-3
[180.919741] Dynamic subtest pipe-A-DP-3: SKIP (0.002s)
[180.932291] Starting dynamic subtest: pipe-B-DP-3
[180.953799] Dynamic subtest pipe-B-DP-3: SKIP (0.002s)
[180.966556] Starting dynamic subtest: pipe-C-DP-3
[180.992978] Dynamic subtest pipe-C-DP-3: SKIP (0.002s)
[181.006518] Starting dynamic subtest: pipe-D-DP-3
[181.031797] Dynamic subtest pipe-D-DP-3: SKIP (0.002s)
[181.033803] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.011s)
[181.274713] [034/130] (848s left) gem_lmem_swapping (verify-random-ccs)
[184.017018] Starting subtest: verify-random-ccs
[184.017954] Starting dynamic subtest: lmem0
[190.844768] Dynamic subtest lmem0: SUCCESS (6.828s)
[190.845690] Subtest verify-random-ccs: SUCCESS (6.828s)
[191.978639] [FACT gem_lmem_swapping (verify-random-ccs)] deleted: kernel.kmod_is_loaded.i915: true
[191.980519] [035/130] (838s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[193.518755] Starting subtest: plane-primary-toggle-with-vblank-wait
[193.519684] Starting dynamic subtest: pipe-A-DP-3
[193.753169] Dynamic subtest pipe-A-DP-3: SUCCESS (0.233s)
[193.894564] Starting dynamic subtest: pipe-B-DP-3
[194.159984] Dynamic subtest pipe-B-DP-3: SUCCESS (0.278s)
[194.250266] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (0.732s)
[194.420703] [FACT kms_atomic_transition (plane-primary-toggle-with-vblank-wait)] new: kernel.kmod_is_loaded.i915: true
[194.423307] [036/130] (835s left) gem_exec_alignment (pi-isolated)
[194.513152] Starting subtest: pi-isolated
[211.308782] Subtest pi-isolated: SUCCESS (16.795s)
[211.717712] [037/130] (818s left) kms_pm_rpm (modeset-stress-extra-wait)
[213.499246] Starting subtest: modeset-stress-extra-wait
[266.352003] Subtest modeset-stress-extra-wait: SUCCESS (52.854s)
[266.452415] [038/130] (763s left) gem_exec_params (cliprects_ptr-dirt)
[266.534231] Starting subtest: cliprects_ptr-dirt
[266.535125] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[266.608600] [039/130] (763s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[266.793326] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[266.795005] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[266.886631] [040/130] (763s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[267.072077] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[267.072978] Starting dynamic subtest: pipe-A-DP-3
[267.081260] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[267.093049] Starting dynamic subtest: pipe-B-DP-3
[267.101303] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[267.112891] Starting dynamic subtest: pipe-C-DP-3
[267.121150] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[267.132860] Starting dynamic subtest: pipe-D-DP-3
[267.143835] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[267.145957] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.007s)
[267.459899] [041/130] (763s left) kms_busy (extended-modeset-hang-newfb)
[267.641967] Starting subtest: extended-modeset-hang-newfb
[267.642917] Starting dynamic subtest: pipe-A
[283.378332] Dynamic subtest pipe-A: SUCCESS (15.735s)
[283.399766] Starting dynamic subtest: pipe-D
[299.136904] Dynamic subtest pipe-D: SUCCESS (15.753s)
[299.140570] Subtest extended-modeset-hang-newfb: SUCCESS (31.498s)
[299.359205] [042/130] (731s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[299.539620] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[299.541248] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[299.613266] [043/130] (730s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[299.687772] Starting subtest: multi-wait-available-unsubmitted-signaled
[299.688700] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.001s)
[299.744981] [044/130] (730s left) gem_softpin (evict-prime)
[299.818211] Starting subtest: evict-prime
[299.819101] Starting dynamic subtest: rcs0
[301.083212] Dynamic subtest rcs0: SUCCESS (1.265s)
[301.096395] Starting dynamic subtest: bcs0
[302.249404] Dynamic subtest bcs0: SUCCESS (1.165s)
[302.263952] Starting dynamic subtest: vcs0
[303.428320] Dynamic subtest vcs0: SUCCESS (1.178s)
[303.445472] Starting dynamic subtest: vcs1
[304.610112] Dynamic subtest vcs1: SUCCESS (1.181s)
[304.623748] Starting dynamic subtest: vecs0
[305.781306] Dynamic subtest vecs0: SUCCESS (1.171s)
[305.794725] Starting dynamic subtest: vecs1
[306.959156] Dynamic subtest vecs1: SUCCESS (1.177s)
[306.971875] Starting dynamic subtest: ccs0
[308.140196] Dynamic subtest ccs0: SUCCESS (1.180s)
[308.154488] Starting dynamic subtest: all
[309.341150] Dynamic subtest all: SUCCESS (1.200s)
[309.342400] Subtest evict-prime: SUCCESS (9.523s)
[309.407294] [045/130] (721s left) gem_exec_schedule (preempt-queue)
[309.492720] Subtest preempt-queue: SKIP (0.000s)
[309.815128] [046/130] (720s left) gem_userptr_blits (coherency-unsync)
[309.892681] Subtest coherency-unsync: SKIP (0.000s)
[310.001081] [047/130] (720s left) kms_cursor_legacy (single-move)
[310.183414] Starting subtest: single-move
[310.184288] Starting dynamic subtest: pipe-A
[315.572965] Dynamic subtest pipe-A: SUCCESS (5.380s)
[315.585770] Starting dynamic subtest: pipe-B
[320.943858] Dynamic subtest pipe-B: SUCCESS (5.379s)
[320.956918] Starting dynamic subtest: pipe-C
[326.323670] Dynamic subtest pipe-C: SUCCESS (5.379s)
[326.336761] Starting dynamic subtest: pipe-D
[331.703025] Dynamic subtest pipe-D: SUCCESS (5.378s)
[331.715991] Starting dynamic subtest: all-pipes
[337.082946] Dynamic subtest all-pipes: SUCCESS (5.379s)
[337.083960] Subtest single-move: SUCCESS (26.898s)
[337.147522] [048/130] (693s left) kms_vblank (query-forked-busy)
[337.336710] Starting subtest: query-forked-busy
[337.338772] Starting dynamic subtest: pipe-A-DP-3
[339.878675] Dynamic subtest pipe-A-DP-3: SUCCESS (2.538s)
[339.935285] Starting dynamic subtest: pipe-D-DP-3
[342.438939] Dynamic subtest pipe-D-DP-3: SUCCESS (2.549s)
[342.440465] Subtest query-forked-busy: SUCCESS (5.103s)
[342.691722] [049/130] (688s left) gem_pwrite (basic-exhaustion)
[342.762839] Subtest basic-exhaustion: SKIP (0.000s)
[342.823475] [050/130] (688s left) gem_userptr_blits (sync-unmap)
[342.901772] Starting subtest: sync-unmap
[342.922916] Subtest sync-unmap: SUCCESS (0.021s)
[343.044851] [051/130] (687s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[343.236089] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[344.447018] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (1.211s)
[344.642520] [052/130] (686s left) perf_pmu (busy-double-start)
[344.706976] Starting subtest: busy-double-start
[344.707847] Starting dynamic subtest: rcs0
[348.333230] Dynamic subtest rcs0: SUCCESS (3.626s)
[348.349943] Starting dynamic subtest: bcs0
[351.929892] Dynamic subtest bcs0: SUCCESS (3.594s)
[351.946477] Starting dynamic subtest: vcs0
[355.522849] Dynamic subtest vcs0: SUCCESS (3.590s)
[355.539989] Starting dynamic subtest: vcs1
[359.113126] Dynamic subtest vcs1: SUCCESS (3.587s)
[359.129339] Starting dynamic subtest: vecs0
[362.724016] Dynamic subtest vecs0: SUCCESS (3.608s)
[362.740618] Starting dynamic subtest: vecs1
[366.328871] Dynamic subtest vecs1: SUCCESS (3.602s)
[366.345841] Starting dynamic subtest: ccs0
[369.941992] Dynamic subtest ccs0: SUCCESS (3.610s)
[369.943550] Subtest busy-double-start: SUCCESS (25.237s)
[370.027180] [053/130] (661s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[370.099598] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[370.201079] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.102s)
[370.269145] [054/130] (660s left) gem_exec_fence (basic-wait)
[370.495945] Starting subtest: basic-wait
[370.497378] Starting dynamic subtest: rcs0
[370.621590] Dynamic subtest rcs0: SUCCESS (0.124s)
[370.641088] Starting dynamic subtest: bcs0
[370.677187] Dynamic subtest bcs0: SUCCESS (0.054s)
[370.695706] Starting dynamic subtest: vcs0
[370.734725] Dynamic subtest vcs0: SUCCESS (0.056s)
[370.778478] Starting dynamic subtest: vcs1
[370.793217] Dynamic subtest vcs1: SUCCESS (0.057s)
[370.812377] Starting dynamic subtest: vecs0
[370.846243] Dynamic subtest vecs0: SUCCESS (0.052s)
[370.862963] Starting dynamic subtest: vecs1
[370.896221] Dynamic subtest vecs1: SUCCESS (0.049s)
[370.922356] Starting dynamic subtest: ccs0
[370.947548] Dynamic subtest ccs0: SUCCESS (0.050s)
[370.948750] Subtest basic-wait: SUCCESS (0.453s)
[371.659683] [FACT gem_exec_fence (basic-wait)] new: kernel.kmod_is_loaded.vgem: true
[371.662165] [055/130] (659s left) kms_addfb_basic (addfb25-modifier-no-flag)
[371.848933] Starting subtest: addfb25-modifier-no-flag
[371.849833] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[371.935728] [056/130] (659s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[372.119681] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[372.120589] Starting dynamic subtest: pipe-A-DP-3
[372.141779] Dynamic subtest pipe-A-DP-3: SKIP (0.002s)
[372.154841] Starting dynamic subtest: pipe-B-DP-3
[372.176055] Dynamic subtest pipe-B-DP-3: SKIP (0.002s)
[372.189119] Starting dynamic subtest: pipe-C-DP-3
[372.214752] Dynamic subtest pipe-C-DP-3: SKIP (0.002s)
[372.228588] Starting dynamic subtest: pipe-D-DP-3
[372.253748] Dynamic subtest pipe-D-DP-3: SKIP (0.002s)
[372.255764] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.013s)
[372.496524] [057/130] (658s left) kms_fb_coherency (memset-crc)
[372.684948] Starting subtest: memset-crc
[372.685823] Starting dynamic subtest: mmap-offset-fixed
[373.286477] Dynamic subtest mmap-offset-fixed: CRASH (0.275s)
[373.629856] Subtest memset-crc: CRASH (0.607s)
[373.725848] [058/130] (657s left) gem_lmem_swapping (massive)
[376.308034] Starting subtest: massive
[376.308892] Starting dynamic subtest: lmem0
[383.749452] Dynamic subtest lmem0: SUCCESS (7.441s)
[383.750330] Subtest massive: SUCCESS (7.442s)
[385.200445] [FACT gem_lmem_swapping (massive)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[385.201370] [FACT gem_lmem_swapping (massive)] deleted: kernel.kmod_is_loaded.i915: true
[385.203039] [059/130] (646s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[386.836836] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[386.982914] [FACT kms_chamelium_hpd (hdmi-hpd-after-suspend)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[386.985565] [FACT kms_chamelium_hpd (hdmi-hpd-after-suspend)] new: kernel.kmod_is_loaded.i915: true
[386.988829] [060/130] (644s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[387.177416] Starting subtest: async-flip-with-page-flip-events-linear
[387.415978] Starting dynamic subtest: pipe-A-DP-3
[389.707747] Dynamic subtest pipe-A-DP-3: SUCCESS (2.291s)
[389.953209] Starting dynamic subtest: pipe-B-DP-3
[392.039046] Dynamic subtest pipe-B-DP-3: SUCCESS (2.097s)
[392.268159] Starting dynamic subtest: pipe-C-DP-3
[394.360058] Dynamic subtest pipe-C-DP-3: SUCCESS (2.102s)
[394.584294] Starting dynamic subtest: pipe-D-DP-3
[396.677941] Dynamic subtest pipe-D-DP-3: SUCCESS (2.101s)
[396.681764] Subtest async-flip-with-page-flip-events-linear: SUCCESS (9.498s)
[397.063504] [061/130] (634s left) gem_userptr_blits (stress-mm-invalidate-close-overlap)
[397.159060] Starting subtest: stress-mm-invalidate-close-overlap
[399.307113] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.148s)
[399.460772] [062/130] (632s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[399.652794] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[402.521103] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (2.869s)
[402.687617] [063/130] (629s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[402.880952] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[402.895179] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.014s)
[402.951939] [064/130] (628s left) kms_flip (plain-flip-fb-recreate-interruptible)
[403.147354] Starting subtest: plain-flip-fb-recreate-interruptible
[403.152087] Starting dynamic subtest: A-DP3
[411.265624] Dynamic subtest A-DP3: SUCCESS (8.112s)
[411.306180] Starting dynamic subtest: B-DP3
[419.308897] Dynamic subtest B-DP3: SUCCESS (8.038s)
[419.353247] Starting dynamic subtest: C-DP3
[427.347838] Dynamic subtest C-DP3: SUCCESS (8.034s)
[427.384100] Starting dynamic subtest: D-DP3
[435.389022] Dynamic subtest D-DP3: SUCCESS (8.036s)
[435.397343] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (32.249s)
[435.706994] [065/130] (596s left) gem_exec_fence (syncobj-repeat)
[436.243278] Starting subtest: syncobj-repeat
[436.567249] Subtest syncobj-repeat: SUCCESS (0.324s)
[436.918329] [066/130] (595s left) i915_query (query-topology-coherent-slice-mask)
[437.004254] Starting subtest: query-topology-coherent-slice-mask
[437.006160] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[437.131230] [067/130] (594s left) kms_cursor_crc (cursor-onscreen-512x512)
[437.591698] Starting subtest: cursor-onscreen-512x512
[437.593398] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[437.815832] [068/130] (594s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[438.004038] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[438.005735] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[438.085768] [069/130] (594s left) kms_plane_scaling (invalid-num-scalers)
[438.274630] Starting subtest: invalid-num-scalers
[438.282117] Starting dynamic subtest: pipe-A-DP-3-invalid-num-scalers
[438.302937] Dynamic subtest pipe-A-DP-3-invalid-num-scalers: SUCCESS (0.021s)
[438.321961] Starting dynamic subtest: pipe-B-DP-3-invalid-num-scalers
[438.347910] Dynamic subtest pipe-B-DP-3-invalid-num-scalers: SUCCESS (0.037s)
[438.366564] Starting dynamic subtest: pipe-C-DP-3-invalid-num-scalers
[438.392277] Dynamic subtest pipe-C-DP-3-invalid-num-scalers: SUCCESS (0.037s)
[438.411415] Starting dynamic subtest: pipe-D-DP-3-invalid-num-scalers
[438.437108] Dynamic subtest pipe-D-DP-3-invalid-num-scalers: SUCCESS (0.038s)
[438.437930] Subtest invalid-num-scalers: SUCCESS (0.163s)
[438.535514] [070/130] (593s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[438.613958] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[438.682335] [071/130] (593s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[440.505583] Starting subtest: gem-execbuf-stress-pc8
[440.647525] Subtest gem-execbuf-stress-pc8: SKIP (0.144s)
[440.848332] [072/130] (591s left) syncobj_timeline (wait-any-interrupted)
[440.927305] Starting subtest: wait-any-interrupted
[441.030883] Subtest wait-any-interrupted: SUCCESS (0.103s)
[441.153135] [073/130] (591s left) sw_sync (sync_merge_same)
[441.202241] Starting subtest: sync_merge_same
[441.203144] Subtest sync_merge_same: SUCCESS (0.000s)
[441.252445] [074/130] (591s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[441.441080] Starting subtest: psr-2p-pri-indfb-multidraw
[441.442817] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[441.522028] [075/130] (590s left) kms_hdr (bpc-switch-suspend)
[441.710096] Starting subtest: bpc-switch-suspend
[445.065515] Starting dynamic subtest: pipe-A-DP-3
[465.016790] Dynamic subtest pipe-A-DP-3: SUCCESS (4.998s)
[465.017707] Subtest bpc-switch-suspend: SUCCESS (8.355s)
[465.294451] [076/130] (567s left) api_intel_bb (blit-noreloc-keep-cache)
[465.377025] Starting subtest: blit-noreloc-keep-cache
[465.413399] Subtest blit-noreloc-keep-cache: SUCCESS (0.036s)
[465.526029] [077/130] (567s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[465.715353] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[465.717096] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[465.796495] [078/130] (566s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[465.984023] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[465.986396] Starting dynamic subtest: pipe-A-valid-mode
[466.075783] Dynamic subtest pipe-A-valid-mode: SKIP (0.088s)
[466.077686] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.090s)
[466.227359] [079/130] (566s left) kms_chamelium_frames (hdmi-crc-fast)
[466.496645] Subtest hdmi-crc-fast: SKIP (0.000s)
[466.639456] [080/130] (566s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[466.828757] Starting subtest: primary-4-tiled-reflect-x-0
[477.176918] Subtest primary-4-tiled-reflect-x-0: SUCCESS (10.347s)
[477.466190] [081/130] (555s left) sw_sync (sync_merge)
[477.513394] Starting subtest: sync_merge
[477.514335] Subtest sync_merge: SUCCESS (0.000s)
[477.562715] [082/130] (555s left) gem_ctx_persistence (engines-mixed-process)
[477.649709] Starting subtest: engines-mixed-process
[477.650668] Starting dynamic subtest: rcs0
[479.334028] Dynamic subtest rcs0: SUCCESS (1.682s)
[479.348910] Starting dynamic subtest: bcs0
[481.296042] Dynamic subtest bcs0: SUCCESS (1.962s)
[481.311895] Starting dynamic subtest: vcs0
[483.280540] Dynamic subtest vcs0: SUCCESS (1.983s)
[483.297492] Starting dynamic subtest: vcs1
[485.345444] Dynamic subtest vcs1: SUCCESS (2.063s)
[485.362097] Starting dynamic subtest: vecs0
[487.314514] Dynamic subtest vecs0: SUCCESS (1.967s)
[487.331434] Starting dynamic subtest: vecs1
[489.289864] Dynamic subtest vecs1: SUCCESS (1.974s)
[489.305472] Starting dynamic subtest: ccs0
[491.353459] Dynamic subtest ccs0: SUCCESS (2.062s)
[491.354496] Subtest engines-mixed-process: SUCCESS (13.704s)
[491.423672] [083/130] (541s left) gem_exec_parallel (userptr)
[491.513690] Starting subtest: userptr
[491.514637] Starting dynamic subtest: rcs0
[493.036513] Dynamic subtest rcs0: SUCCESS (1.523s)
[493.053581] Starting dynamic subtest: bcs0
[494.520609] Dynamic subtest bcs0: SUCCESS (1.483s)
[494.536106] Starting dynamic subtest: vcs0
[496.021638] Dynamic subtest vcs0: SUCCESS (1.500s)
[496.041218] Starting dynamic subtest: vcs1
[497.523656] Dynamic subtest vcs1: SUCCESS (1.501s)
[497.543431] Starting dynamic subtest: vecs0
[498.997729] Dynamic subtest vecs0: SUCCESS (1.473s)
[499.016912] Starting dynamic subtest: vecs1
[500.470813] Dynamic subtest vecs1: SUCCESS (1.472s)
[500.489524] Starting dynamic subtest: ccs0
[501.926806] Dynamic subtest ccs0: SUCCESS (1.455s)
[501.927678] Subtest userptr: SUCCESS (10.415s)
[502.213205] [084/130] (530s left) kms_flip (absolute-wf_vblank-interruptible)
[502.436485] Starting subtest: absolute-wf_vblank-interruptible
[502.441285] Starting dynamic subtest: A-DP3
[510.264747] Dynamic subtest A-DP3: SUCCESS (7.823s)
[510.282928] Starting dynamic subtest: B-DP3
[518.012889] Dynamic subtest B-DP3: SUCCESS (7.746s)
[518.029023] Starting dynamic subtest: C-DP3
[525.767796] Dynamic subtest C-DP3: SUCCESS (7.753s)
[525.784433] Starting dynamic subtest: D-DP3
[533.493720] Dynamic subtest D-DP3: SUCCESS (7.724s)
[533.496180] Subtest absolute-wf_vblank-interruptible: SUCCESS (31.059s)
[533.778639] [085/130] (499s left) kms_force_connector_basic (prune-stale-modes)
[533.887545] Starting subtest: prune-stale-modes
[533.910422] Subtest prune-stale-modes: SUCCESS (0.024s)
[534.189904] [086/130] (499s left) gem_ctx_persistence (processes)
[534.273880] Starting subtest: processes
[536.282617] Subtest processes: SUCCESS (2.009s)
[536.362870] [087/130] (496s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[536.555362] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[536.557077] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[536.642048] [088/130] (496s left) gem_exec_flush (basic-uc-ro-default)
[536.728709] Subtest basic-uc-ro-default: SKIP (0.000s)
[536.809911] [089/130] (496s left) kms_psr (pr-dpms)
[536.996406] Subtest pr-dpms: SKIP (0.000s)
[537.055776] [090/130] (496s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[537.248362] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[537.250066] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[537.347775] [091/130] (496s left) kms_lease (lease-invalid-crtc)
[537.532157] Starting subtest: lease-invalid-crtc
[537.534660] Starting dynamic subtest: pipe-A-DP-3
[537.535531] Dynamic subtest pipe-A-DP-3: SUCCESS (0.000s)
[537.549703] Starting dynamic subtest: pipe-B-DP-3
[537.550785] Dynamic subtest pipe-B-DP-3: SUCCESS (0.000s)
[537.565063] Starting dynamic subtest: pipe-C-DP-3
[537.566311] Dynamic subtest pipe-C-DP-3: SUCCESS (0.000s)
[537.580113] Starting dynamic subtest: pipe-D-DP-3
[537.581035] Dynamic subtest pipe-D-DP-3: SUCCESS (0.000s)
[537.581853] Subtest lease-invalid-crtc: SUCCESS (0.007s)
[537.630480] [092/130] (495s left) i915_query (query-topology-unsupported)
[537.708544] Starting subtest: query-topology-unsupported
[537.710401] Subtest query-topology-unsupported: SKIP (0.000s)
[537.796479] [093/130] (495s left) prime_self_import (export-vs-gem_close-race)
[537.844115] Starting subtest: export-vs-gem_close-race
[542.931406] Subtest export-vs-gem_close-race: SUCCESS (5.088s)
[542.990866] [094/130] (490s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[543.179299] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[548.941011] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: FAIL (5.414s)
[549.025250] [095/130] (484s left) gem_exec_reloc (basic-cpu-active)
[549.105613] Subtest basic-cpu-active: SKIP (0.000s)
[549.198049] [096/130] (484s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[549.384552] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[549.386230] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[549.484620] [097/130] (484s left) syncobj_timeline (invalid-transfer-non-existent-point)
[549.569710] Starting subtest: invalid-transfer-non-existent-point
[549.570610] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[549.675326] [098/130] (484s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[549.870587] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[549.872301] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[549.959476] [099/130] (484s left) kms_vblank (query-idle-hang)
[550.145010] Starting subtest: query-idle-hang
[550.147321] Starting dynamic subtest: pipe-A-DP-3
[577.006954] Dynamic subtest pipe-A-DP-3: SUCCESS (26.858s)
[577.038468] Starting dynamic subtest: pipe-D-DP-3
[602.001612] Dynamic subtest pipe-D-DP-3: SUCCESS (24.984s)
[602.002494] Subtest query-idle-hang: SUCCESS (51.852s)
[602.266725] [100/130] (431s left) i915_drm_fdinfo (busy-idle)
[602.337991] Starting subtest: busy-idle
[602.338838] Starting dynamic subtest: rcs0
[602.362417] Dynamic subtest rcs0: SKIP (0.023s)
[602.377347] Starting dynamic subtest: bcs0
[602.379636] Dynamic subtest bcs0: SKIP (0.000s)
[602.394142] Starting dynamic subtest: vcs0
[602.396387] Dynamic subtest vcs0: SKIP (0.000s)
[602.410788] Starting dynamic subtest: vcs1
[602.413131] Dynamic subtest vcs1: SKIP (0.000s)
[602.427174] Starting dynamic subtest: vecs0
[602.429598] Dynamic subtest vecs0: SKIP (0.000s)
[602.443611] Starting dynamic subtest: vecs1
[602.445986] Dynamic subtest vecs1: SKIP (0.000s)
[602.459996] Starting dynamic subtest: ccs0
[602.462311] Dynamic subtest ccs0: SKIP (0.000s)
[602.464818] Subtest busy-idle: SKIP (0.032s)
[602.515640] [101/130] (431s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[602.703395] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[607.304824] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.602s)
[607.441178] [102/130] (426s left) kms_psr (psr-primary-mmap-cpu)
[607.626419] Subtest psr-primary-mmap-cpu: SKIP (0.000s)
[607.686481] [103/130] (426s left) kms_pm_rpm (dpms-non-lpsp)
[609.499781] Starting subtest: dpms-non-lpsp
[609.702537] Subtest dpms-non-lpsp: SUCCESS (0.202s)
[609.882030] [104/130] (424s left) device_reset (unbind-reset-rebind)
[609.967759] Starting subtest: unbind-reset-rebind
[612.371805] Subtest unbind-reset-rebind: SUCCESS (2.405s)
[612.436316] [105/130] (421s left) kms_pipe_crc_basic (read-crc)
[612.623621] Starting subtest: read-crc
[612.624534] Starting dynamic subtest: pipe-A-DP-3
[613.361648] Dynamic subtest pipe-A-DP-3: SUCCESS (0.737s)
[613.380046] Starting dynamic subtest: pipe-B-DP-3
[613.928670] Dynamic subtest pipe-B-DP-3: SUCCESS (0.566s)
[613.947148] Starting dynamic subtest: pipe-C-DP-3
[614.452581] Dynamic subtest pipe-C-DP-3: SUCCESS (0.521s)
[614.476452] Starting dynamic subtest: pipe-D-DP-3
[615.019810] Dynamic subtest pipe-D-DP-3: SUCCESS (0.564s)
[615.020730] Subtest read-crc: SUCCESS (2.397s)
[615.215062] [106/130] (419s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[615.407480] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[615.409192] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[615.489309] [107/130] (418s left) kms_async_flips (test-time-stamp)
[615.677573] Starting subtest: test-time-stamp
[615.910173] Starting dynamic subtest: pipe-A-DP-3
[616.223348] Dynamic subtest pipe-A-DP-3: SUCCESS (0.312s)
[616.474229] Starting dynamic subtest: pipe-B-DP-3
[616.611306] Dynamic subtest pipe-B-DP-3: SUCCESS (0.150s)
[616.841257] Starting dynamic subtest: pipe-C-DP-3
[616.970736] Dynamic subtest pipe-C-DP-3: SUCCESS (0.143s)
[617.216600] Starting dynamic subtest: pipe-D-DP-3
[617.354302] Dynamic subtest pipe-D-DP-3: SUCCESS (0.150s)
[617.355282] Subtest test-time-stamp: SUCCESS (1.677s)
[617.798748] [108/130] (416s left) api_intel_bb (reset-bb)
[617.883750] Starting subtest: reset-bb
[617.911411] Subtest reset-bb: SUCCESS (0.028s)
[618.019311] [109/130] (416s left) gem_exec_whisper (basic-normal-all)
[618.111785] Starting subtest: basic-normal-all
[620.376775] Subtest basic-normal-all: SUCCESS (2.264s)
[620.622202] [110/130] (414s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[620.818460] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[620.875981] [111/130] (413s left) fbdev (eof)
[620.944106] Starting subtest: eof
[620.945037] Subtest eof: SUCCESS (0.000s)
[621.003166] [112/130] (413s left) kms_psr (pr-cursor-blt)
[621.188880] Subtest pr-cursor-blt: SKIP (0.000s)
[621.258060] [113/130] (413s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[621.341144] Starting subtest: y-tiled-to-vebox-yf-tiled
[621.343623] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[621.511360] [114/130] (413s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[621.705425] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[621.707205] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[621.800810] [115/130] (413s left) kms_plane (pixel-format-source-clamping)
[621.989496] Starting subtest: pixel-format-source-clamping
[622.026025] Starting dynamic subtest: pipe-A-plane-0
[629.442721] Dynamic subtest pipe-A-plane-0: SUCCESS (7.416s)
[629.459293] Starting dynamic subtest: pipe-A-plane-3
[633.309741] Dynamic subtest pipe-A-plane-3: SUCCESS (3.866s)
[633.326506] Starting dynamic subtest: pipe-A-plane-5
[633.330070] Dynamic subtest pipe-A-plane-5: SUCCESS (0.000s)
[633.534444] Starting dynamic subtest: pipe-B-plane-0
[640.771029] Dynamic subtest pipe-B-plane-0: SUCCESS (7.266s)
[640.788747] Starting dynamic subtest: pipe-B-plane-3
[644.954529] Dynamic subtest pipe-B-plane-3: SUCCESS (4.182s)
[644.970960] Starting dynamic subtest: pipe-B-plane-5
[644.971795] Dynamic subtest pipe-B-plane-5: SUCCESS (0.000s)
[645.029690] Subtest pixel-format-source-clamping: SUCCESS (23.040s)
[645.294465] [116/130] (389s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[645.490663] Starting subtest: 4-tiled-addfb-size-offset-overflow
[645.491568] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.001s)
[645.593167] [117/130] (389s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[645.777547] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[645.778441] Starting dynamic subtest: pipe-A-valid-mode
[648.160501] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.383s)
[648.161430] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SUCCESS (2.384s)
[648.392645] [118/130] (386s left) gem_mmap_offset (oob-read)
[648.471610] Starting subtest: oob-read
[648.472520] Subtest oob-read: SUCCESS (0.000s)
[648.548885] [119/130] (386s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[648.737344] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[648.739053] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[648.815791] [120/130] (386s left) kms_chamelium_color (ctm-blue-to-red)
[649.002430] Subtest ctm-blue-to-red: SKIP (0.000s)
[649.063518] [121/130] (386s left) gem_eio (wait-immediate)
[649.346125] Starting subtest: wait-immediate
[649.989431] Subtest wait-immediate: SUCCESS (0.644s)
[650.166197] [122/130] (385s left) gem_exec_suspend (basic-s3-devices)
[650.252638] Starting subtest: basic-S3-devices
[650.253565] Starting dynamic subtest: smem
[660.430608] Dynamic subtest smem: SUCCESS (10.177s)
[660.449198] Starting dynamic subtest: lmem0
[670.363561] Dynamic subtest lmem0: SUCCESS (9.932s)
[670.364636] Subtest basic-S3-devices: SUCCESS (20.111s)
[670.569569] [123/130] (364s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[670.644611] Starting subtest: invalid-multi-wait-unsubmitted
[670.645524] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[670.715610] [124/130] (364s left) gem_exec_balancer (full-late-pulse)
[670.803084] Starting subtest: full-late-pulse
[672.880494] Subtest full-late-pulse: SUCCESS (2.077s)
[673.252924] [125/130] (362s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[673.445402] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[673.447158] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[673.535363] [126/130] (362s left) syncobj_wait (single-wait-for-submit-submitted)
[673.613725] Starting subtest: single-wait-for-submit-submitted
[673.723589] Subtest single-wait-for-submit-submitted: SUCCESS (0.108s)
[673.842301] [127/130] (361s left) gem_exec_schedule (semaphore-resolve)
[673.933882] Starting subtest: semaphore-resolve
[674.016197] Subtest semaphore-resolve: SUCCESS (0.082s)
[674.381017] [128/130] (361s left) syncobj_basic (bad-pad-handle-to-fd)
[674.461027] Starting subtest: bad-pad-handle-to-fd
[674.461850] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[674.554737] [129/130] (361s left) gen7_exec_parse (chained-batch)
[674.637405] Subtest chained-batch: SKIP (0.000s)
[674.697297] [130/130] (361s left) kms_cursor_crc (cursor-onscreen-256x256)
[675.107662] Starting subtest: cursor-onscreen-256x256
[675.112780] Starting dynamic subtest: pipe-A-DP-3
[677.833540] Dynamic subtest pipe-A-DP-3: SUCCESS (2.720s)
[677.890176] Starting dynamic subtest: pipe-D-DP-3
[680.614706] Dynamic subtest pipe-D-DP-3: SUCCESS (2.739s)
[680.615635] Subtest cursor-onscreen-256x256: SUCCESS (5.507s)
[680.907623] 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.