[65.813631] Initializing watchdogs
[65.813715]   /dev/watchdog0
[65.843530] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[65.858475] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[65.863165] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[65.866826] [001/132] (960s left) kms_flip (2x-flip-vs-dpms-on-nop)
[67.868994] Starting subtest: 2x-flip-vs-dpms-on-nop
[67.886718] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.018s)
[68.095982] [002/132] (958s left) kms_psr (psr2-dpms)
[70.087562] Subtest psr2-dpms: SKIP (0.000s)
[70.150986] [003/132] (956s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[70.197794] Starting subtest: invalid-single-wait-all-unsubmitted
[70.199346] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[70.387390] [004/132] (956s left) kms_atomic (plane-overlay-legacy)
[72.375932] Starting subtest: plane-overlay-legacy
[72.377381] Starting dynamic subtest: pipe-A-HDMI-A-4
[72.909135] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.532s)
[72.910728] Subtest plane-overlay-legacy: SUCCESS (0.534s)
[73.103755] [005/132] (953s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[75.114687] Starting subtest: y-tiled-addfb-size-offset-overflow
[75.116311] Subtest y-tiled-addfb-size-offset-overflow: SUCCESS (0.001s)
[75.345934] [006/132] (951s left) gem_ctx_param (set-priority-invalid-size)
[75.391851] Starting subtest: set-priority-invalid-size
[75.393562] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[75.543655] [007/132] (951s left) api_intel_bb (intel-bb-blit-x)
[75.589896] Starting subtest: intel-bb-blit-x
[76.256314] Subtest intel-bb-blit-x: SUCCESS (0.667s)
[76.444854] [008/132] (950s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[78.440644] Starting subtest: psr-indfb-scaledprimary
[78.444162] Subtest psr-indfb-scaledprimary: SKIP (0.000s)
[78.676987] [009/132] (948s left) kms_joiner (invalid-modeset-force-ultra-joiner)
[80.666574] Starting subtest: invalid-modeset-force-ultra-joiner
[80.670153] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s)
[80.823734] [010/132] (946s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[82.838496] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[82.903047] [011/132] (944s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[84.895776] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[84.899141] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[85.155411] [012/132] (942s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[87.145341] Starting subtest: sprite-rotation-90-pos-100-0
[94.116370] Subtest sprite-rotation-90-pos-100-0: SUCCESS (6.970s)
[94.379864] [013/132] (933s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[96.383474] Starting subtest: fbc-1p-pri-indfb-multidraw
[105.335738] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (8.952s)
[105.548357] [014/132] (922s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[107.538527] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[107.541584] Subtest plane-all-modeset-transition-fencing-internal-panels: SKIP (0.000s)
[107.739916] [015/132] (919s left) syncobj_timeline (signal-point-0)
[107.787583] Starting subtest: signal-point-0
[107.789191] Subtest signal-point-0: SUCCESS (0.000s)
[107.956195] [016/132] (919s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[109.943402] Starting subtest: cursorA-vs-flipB-atomic-transitions
[109.946450] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.002s)
[110.118501] [017/132] (917s left) kms_psr (fbc-pr-basic)
[112.118098] Subtest fbc-pr-basic: SKIP (0.000s)
[112.189188] [018/132] (915s left) kms_joiner (basic-ultra-joiner)
[114.174470] Starting subtest: basic-ultra-joiner
[114.177391] Subtest basic-ultra-joiner: SKIP (0.000s)
[114.423095] [019/132] (913s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[116.411321] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc
[116.412856] Starting dynamic subtest: pipe-A-HDMI-A-4
[120.912494] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (4.493s)
[120.925923] Starting dynamic subtest: pipe-B-HDMI-A-4
[121.654809] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.735s)
[121.683577] Starting dynamic subtest: pipe-C-HDMI-A-4
[122.394297] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.734s)
[122.426131] Starting dynamic subtest: pipe-D-HDMI-A-4
[123.152324] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.750s)
[123.155267] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SUCCESS (6.733s)
[123.443425] [020/132] (904s left) kms_cursor_crc (cursor-random-256x256)
[125.644029] Starting subtest: cursor-random-256x256
[125.650153] Starting dynamic subtest: pipe-A-HDMI-A-4
[130.252283] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (4.601s)
[130.283460] Starting dynamic subtest: pipe-D-HDMI-A-4
[134.745915] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (4.470s)
[134.747474] Subtest cursor-random-256x256: SUCCESS (9.101s)
[135.091927] [021/132] (893s left) gem_exec_fence (syncobj-timeline-chain-engines)
[135.745781] Starting subtest: syncobj-timeline-chain-engines
[135.879738] Subtest syncobj-timeline-chain-engines: SUCCESS (0.135s)
[136.251755] [FACT gem_exec_fence (syncobj-timeline-chain-engines)] new: kernel.kmod_is_loaded.vgem: true
[136.254114] [022/132] (892s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[138.247998] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[138.251396] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[138.492454] [023/132] (890s left) kms_flip (flip-vs-rmfb-interruptible)
[140.484050] Starting subtest: flip-vs-rmfb-interruptible
[140.492246] Starting dynamic subtest: A-HDMI-A4
[148.217782] Dynamic subtest A-HDMI-A4: SUCCESS (7.725s)
[148.232832] Starting dynamic subtest: B-HDMI-A4
[155.930475] Dynamic subtest B-HDMI-A4: SUCCESS (7.711s)
[155.955526] Starting dynamic subtest: C-HDMI-A4
[163.598678] Dynamic subtest C-HDMI-A4: SUCCESS (7.666s)
[163.624544] Starting dynamic subtest: D-HDMI-A4
[171.266833] Dynamic subtest D-HDMI-A4: SUCCESS (7.665s)
[171.269076] Subtest flip-vs-rmfb-interruptible: SUCCESS (30.784s)
[171.524548] [024/132] (857s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[173.516038] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[173.793452] [025/132] (854s left) syncobj_timeline (32bits-limit)
[173.841795] Starting subtest: 32bits-limit
[173.843345] Subtest 32bits-limit: SUCCESS (0.001s)
[173.990749] [026/132] (854s left) gem_close_race (basic-threads)
[174.063970] Starting subtest: basic-threads
[175.270052] Subtest basic-threads: SUCCESS (1.206s)
[175.639747] [027/132] (853s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[175.687593] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[175.689392] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[175.836924] [028/132] (853s left) gem_exec_schedule (lateslice)
[175.898673] Starting subtest: lateslice
[175.900255] Starting dynamic subtest: rcs0
[175.937683] Dynamic subtest rcs0: SUCCESS (0.040s)
[175.947416] Starting dynamic subtest: bcs0
[175.959025] Dynamic subtest bcs0: SUCCESS (0.020s)
[175.968274] Starting dynamic subtest: vcs0
[175.980624] Dynamic subtest vcs0: SUCCESS (0.020s)
[175.990101] Starting dynamic subtest: vcs1
[176.000460] Dynamic subtest vcs1: SUCCESS (0.019s)
[176.009961] Starting dynamic subtest: vecs0
[176.023386] Dynamic subtest vecs0: SUCCESS (0.022s)
[176.025222] Subtest lateslice: SUCCESS (0.127s)
[176.510359] [029/132] (852s left) i915_drm_fdinfo (all-busy-idle-check-all)
[176.558333] Starting subtest: all-busy-idle-check-all
[176.576255] Subtest all-busy-idle-check-all: SKIP (0.017s)
[176.721433] [030/132] (852s left) kms_psr (fbc-psr2-sprite-render)
[178.771902] Subtest fbc-psr2-sprite-render: SKIP (0.000s)
[178.849023] [031/132] (850s left) kms_plane_alpha_blend (alpha-transparent-fb)
[180.836395] Starting subtest: alpha-transparent-fb
[181.104908] Starting dynamic subtest: pipe-A-HDMI-A-4
[181.580499] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.475s)
[181.592350] Starting dynamic subtest: pipe-D-HDMI-A-4
[182.083300] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.499s)
[182.084837] Subtest alpha-transparent-fb: SUCCESS (1.247s)
[182.304566] [032/132] (847s left) kms_hdmi_inject (inject-audio)
[182.401222] Starting subtest: inject-audio
[182.519219] Subtest inject-audio: SUCCESS (0.120s)
[183.761473] [033/132] (845s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf)
[185.760815] Subtest psr2-overlay-plane-update-continuous-sf: SKIP (0.000s)
[185.821631] [034/132] (843s left) gem_exec_flush (basic-wb-rw-before-default)
[185.875659] Subtest basic-wb-rw-before-default: SKIP (0.000s)
[185.978411] [035/132] (843s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[187.982984] Starting subtest: 4-tiled-16bpp-rotate-270
[187.986482] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.000s)
[188.228507] [036/132] (841s left) gem_softpin (full)
[188.297866] Starting subtest: full
[188.317775] Subtest full: SUCCESS (0.022s)
[188.568164] [037/132] (841s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[190.553983] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[190.555507] Starting dynamic subtest: pipe-A-valid-mode
[191.726555] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.170s)
[191.728600] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SUCCESS (1.172s)
[191.974706] [038/132] (837s left) gem_exec_gttfill (all-engines)
[192.052631] Starting subtest: all-engines
[219.229040] Subtest all-engines: SUCCESS (27.173s)
[219.498031] [039/132] (810s left) kms_flip (plain-flip-fb-recreate-interruptible)
[221.539836] Starting subtest: plain-flip-fb-recreate-interruptible
[221.548482] Starting dynamic subtest: A-HDMI-A4
[229.602774] Dynamic subtest A-HDMI-A4: SUCCESS (8.053s)
[229.643043] Starting dynamic subtest: B-HDMI-A4
[237.582255] Dynamic subtest B-HDMI-A4: SUCCESS (7.971s)
[237.619545] Starting dynamic subtest: C-HDMI-A4
[245.549270] Dynamic subtest C-HDMI-A4: SUCCESS (7.959s)
[245.588648] Starting dynamic subtest: D-HDMI-A4
[253.530413] Dynamic subtest D-HDMI-A4: SUCCESS (7.973s)
[253.533131] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (31.991s)
[253.816273] [040/132] (776s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[255.806559] Starting subtest: 2x-flip-vs-cursor-legacy
[255.809862] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.003s)
[256.007310] [041/132] (774s left) gem_exec_fence (basic-busy)
[256.237097] Starting subtest: basic-busy
[256.238824] Starting dynamic subtest: rcs0
[256.323104] Dynamic subtest rcs0: SUCCESS (0.095s)
[256.351249] Starting dynamic subtest: bcs0
[256.386437] Dynamic subtest bcs0: SUCCESS (0.060s)
[256.424982] Starting dynamic subtest: vcs0
[256.451594] Dynamic subtest vcs0: SUCCESS (0.061s)
[256.470169] Starting dynamic subtest: vcs1
[256.505808] Dynamic subtest vcs1: SUCCESS (0.052s)
[256.538834] Starting dynamic subtest: vecs0
[256.562746] Dynamic subtest vecs0: SUCCESS (0.054s)
[256.564595] Subtest basic-busy: SUCCESS (0.337s)
[257.282593] [042/132] (773s left) kms_chamelium_edid (dp-mode-timings)
[259.312277] Subtest dp-mode-timings: SKIP (0.000s)
[259.425754] [043/132] (771s left) kms_cursor_crc (cursor-dpms)
[261.471295] Starting subtest: cursor-dpms
[261.475032] Starting dynamic subtest: pipe-A-HDMI-A-4
[262.553606] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (1.079s)
[262.563444] Starting dynamic subtest: pipe-D-HDMI-A-4
[263.428639] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.873s)
[263.430258] Subtest cursor-dpms: SUCCESS (1.957s)
[264.087290] [044/132] (766s left) kms_psr (fbc-psr-primary-render)
[266.086511] Subtest fbc-psr-primary-render: SKIP (0.000s)
[266.160006] [045/132] (764s left) kms_flip (2x-plain-flip-fb-recreate)
[268.143925] Starting subtest: 2x-plain-flip-fb-recreate
[268.162530] Subtest 2x-plain-flip-fb-recreate: SKIP (0.018s)
[268.363298] [046/132] (762s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[268.417435] Starting subtest: y-tiled-to-vebox-x-tiled
[268.418949] Starting dynamic subtest: smem
[268.499817] Dynamic subtest smem: SUCCESS (0.082s)
[268.509908] Starting dynamic subtest: lmem0
[269.258249] Dynamic subtest lmem0: SUCCESS (0.754s)
[269.259907] Subtest y-tiled-to-vebox-x-tiled: SUCCESS (0.838s)
[269.577188] [047/132] (761s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[271.588807] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[272.687636] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.095s)
[272.902494] [048/132] (757s left) gem_ctx_persistence (hostile)
[272.956629] Starting subtest: hostile
[283.084716] Subtest hostile: SUCCESS (10.121s)
[283.273167] [049/132] (747s left) sriov_basic (enable-vfs-autoprobe-off)
[283.321134] Subtest enable-vfs-autoprobe-off: SKIP (0.000s)
[283.393763] [050/132] (747s left) kms_cursor_crc (cursor-size-hints)
[285.443440] Starting subtest: cursor-size-hints
[285.447274] Starting dynamic subtest: pipe-A-HDMI-A-4
[286.015706] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.570s)
[286.027399] Starting dynamic subtest: pipe-D-HDMI-A-4
[286.448802] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.431s)
[286.450274] Subtest cursor-size-hints: SUCCESS (1.006s)
[287.136426] [051/132] (743s left) gem_sync (basic-store-each)
[287.204917] Starting subtest: basic-store-each
[290.642855] Subtest basic-store-each: SUCCESS (3.443s)
[290.980595] [052/132] (740s left) kms_big_fb (linear-64bpp-rotate-270)
[292.978589] Starting subtest: linear-64bpp-rotate-270
[293.058876] Subtest linear-64bpp-rotate-270: SKIP (0.078s)
[293.330511] [053/132] (738s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[295.326350] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[295.329866] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[295.581574] [054/132] (735s left) gem_exec_reloc (basic-gtt-read-noreloc)
[295.632330] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[295.727925] [055/132] (735s left) kms_sharpness_filter (filter-dpms)
[297.716729] Starting subtest: filter-dpms
[297.726759] Subtest filter-dpms: SKIP (0.002s)
[297.931914] [056/132] (733s left) gem_create (create-valid-nonaligned)
[297.980702] Starting subtest: create-valid-nonaligned
[297.982519] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[298.274161] [057/132] (733s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[300.266220] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[300.269338] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[300.516607] [058/132] (731s left) gem_eio (in-flight-immediate)
[300.724904] Starting subtest: in-flight-immediate
[305.231885] Subtest in-flight-immediate: SUCCESS (4.508s)
[307.375513] [059/132] (724s left) prime_mmap (test_dup)
[307.442631] Starting subtest: test_dup
[307.444185] Starting dynamic subtest: test_dup-smem
[307.501708] Dynamic subtest test_dup-smem: SUCCESS (0.060s)
[307.512267] Starting dynamic subtest: test_dup-lmem0
[307.564695] Dynamic subtest test_dup-lmem0: SUCCESS (0.061s)
[307.566324] Subtest test_dup: SUCCESS (0.125s)
[307.756617] [060/132] (724s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[309.747364] Starting subtest: fbc-rgb565-draw-pwrite
[312.752639] Subtest fbc-rgb565-draw-pwrite: SUCCESS (3.007s)
[312.973306] [061/132] (719s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[314.960243] Starting subtest: primary-4-tiled-reflect-x-0
[315.053127] Subtest primary-4-tiled-reflect-x-0: SKIP (0.091s)
[315.280335] [062/132] (717s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[317.274156] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[317.277527] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[317.517843] [063/132] (715s left) syncobj_wait (wait-for-submit-delayed-submit)
[317.573789] Starting subtest: wait-for-submit-delayed-submit
[317.679750] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[317.839953] [064/132] (714s left) syncobj_timeline (invalid-transfer-bad-pad)
[317.889117] Starting subtest: invalid-transfer-bad-pad
[317.890493] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[318.058433] [065/132] (714s left) kms_color (invalid-ctm-matrix-sizes)
[320.050443] Starting subtest: invalid-ctm-matrix-sizes
[320.052161] Starting dynamic subtest: pipe-A
[320.056621] Dynamic subtest pipe-A: SUCCESS (0.005s)
[320.067278] Starting dynamic subtest: pipe-B
[320.069030] Dynamic subtest pipe-B: SUCCESS (0.007s)
[320.079637] Starting dynamic subtest: pipe-C
[320.090703] Dynamic subtest pipe-C: SUCCESS (0.009s)
[320.100902] Starting dynamic subtest: pipe-D
[320.102499] Dynamic subtest pipe-D: SUCCESS (0.009s)
[320.104162] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.036s)
[320.286394] [066/132] (712s left) gem_pxp (reject-modify-context-protection-off-1)
[322.857182] Starting subtest: reject-modify-context-protection-off-1
[322.860571] Subtest reject-modify-context-protection-off-1: SKIP (0.000s)
[322.984669] [067/132] (709s left) perf_pmu (invalid-open)
[323.034754] Starting subtest: invalid-open
[323.036297] Subtest invalid-open: SUCCESS (0.000s)
[323.192718] [068/132] (709s left) gem_exec_nop (basic-sequential)
[323.255106] Starting subtest: basic-sequential
[326.992581] Subtest basic-sequential: SUCCESS (3.739s)
[327.278452] [069/132] (705s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[329.268346] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[329.269891] Starting dynamic subtest: pipe-A-valid-mode
[329.311278] Dynamic subtest pipe-A-valid-mode: SKIP (0.041s)
[329.314484] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (0.043s)
[329.506937] [070/132] (703s left) gem_eio (in-flight-external)
[329.713302] Starting subtest: in-flight-external
[330.856729] Subtest in-flight-external: SUCCESS (1.134s)
[332.967404] [071/132] (700s left) gem_exec_params (invalid-bsd1-flag-on-render)
[333.022577] Starting subtest: invalid-bsd1-flag-on-render
[333.024490] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[333.208892] [072/132] (700s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[335.199481] Starting subtest: psr-shrfb-scaledprimary
[335.202718] Subtest psr-shrfb-scaledprimary: SKIP (0.000s)
[335.458205] [073/132] (698s left) kms_pm_dc (dc5-dpms-negative)
[338.451749] Starting subtest: dc5-dpms-negative
[342.680042] Subtest dc5-dpms-negative: SUCCESS (4.226s)
[342.807513] [074/132] (690s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[344.803047] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[344.806064] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[345.059890] [075/132] (688s left) kms_vblank (wait-busy-hang)
[347.047410] Starting subtest: wait-busy-hang
[347.048940] Starting dynamic subtest: pipe-A-HDMI-A-4
[373.476884] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (26.429s)
[373.491461] Starting dynamic subtest: pipe-D-HDMI-A-4
[398.486828] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (25.005s)
[398.488239] Subtest wait-busy-hang: SUCCESS (51.443s)
[398.739536] [076/132] (635s left) i915_hangman (gt-error-state-capture)
[398.798634] Starting subtest: gt-error-state-capture
[398.800125] Starting dynamic subtest: rcs0
[409.043938] Dynamic subtest rcs0: SUCCESS (10.245s)
[409.055263] Starting dynamic subtest: bcs0
[419.003044] Dynamic subtest bcs0: SUCCESS (9.957s)
[419.024073] Starting dynamic subtest: vcs0
[429.056180] Dynamic subtest vcs0: SUCCESS (10.051s)
[429.083590] Starting dynamic subtest: vcs1
[439.039770] Dynamic subtest vcs1: SUCCESS (9.982s)
[439.055206] Starting dynamic subtest: vecs0
[449.020962] Dynamic subtest vecs0: SUCCESS (9.979s)
[449.022547] Subtest gt-error-state-capture: SUCCESS (50.223s)
[449.227996] [077/132] (584s left) gem_exec_balancer (bonded-sync)
[449.288122] Starting subtest: bonded-sync
[449.291160] Subtest bonded-sync: SKIP (0.000s)
[449.775160] [078/132] (584s left) gem_ctx_shared (exec-single-timeline)
[449.831025] Starting subtest: exec-single-timeline
[449.832554] Starting dynamic subtest: rcs0
[450.888320] Dynamic subtest rcs0: SUCCESS (1.052s)
[450.899431] Starting dynamic subtest: bcs0
[451.913266] Dynamic subtest bcs0: SUCCESS (1.020s)
[451.924259] Starting dynamic subtest: vcs0
[452.936230] Dynamic subtest vcs0: SUCCESS (1.018s)
[452.947408] Starting dynamic subtest: vcs1
[453.960578] Dynamic subtest vcs1: SUCCESS (1.019s)
[453.971690] Starting dynamic subtest: vecs0
[454.984284] Dynamic subtest vecs0: SUCCESS (1.019s)
[454.985879] Subtest exec-single-timeline: SUCCESS (5.153s)
[455.257457] [079/132] (578s left) kms_psr (psr-dpms)
[457.245030] Subtest psr-dpms: SKIP (0.000s)
[457.319519] [080/132] (576s left) syncobj_timeline (multi-wait-for-submit-signaled)
[457.367515] Starting subtest: multi-wait-for-submit-signaled
[457.368950] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[457.549952] [081/132] (576s left) syncobj_basic (bad-fd-to-handle)
[457.596154] Starting subtest: bad-fd-to-handle
[457.597922] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[457.784639] [082/132] (576s left) gem_eio (in-flight-contexts-1us)
[457.945545] Starting subtest: in-flight-contexts-1us
[471.863904] Subtest in-flight-contexts-1us: SUCCESS (13.919s)
[474.024726] [083/132] (560s left) kms_plane_scaling (planes-upscale-factor-0-25)
[476.032169] Starting subtest: planes-upscale-factor-0-25
[476.033677] Starting dynamic subtest: pipe-A
[476.141721] Dynamic subtest pipe-A: SUCCESS (0.111s)
[476.153471] Starting dynamic subtest: pipe-B
[476.282853] Dynamic subtest pipe-B: SUCCESS (0.140s)
[476.293816] Starting dynamic subtest: pipe-C
[476.424878] Dynamic subtest pipe-C: SUCCESS (0.141s)
[476.436235] Starting dynamic subtest: pipe-D
[476.564600] Dynamic subtest pipe-D: SUCCESS (0.139s)
[476.565932] Subtest planes-upscale-factor-0-25: SUCCESS (0.536s)
[476.755208] [084/132] (557s left) prime_vgem (basic-read)
[476.832275] Starting subtest: basic-read
[476.849926] Subtest basic-read: SKIP (0.016s)
[477.058308] [085/132] (557s left) gem_ctx_exec (basic-close-race)
[477.107767] Starting subtest: basic-close-race
[482.726853] Subtest basic-close-race: SUCCESS (5.614s)
[482.964131] [086/132] (551s left) gem_exec_schedule (u-fairslice)
[483.024819] Starting subtest: u-fairslice
[483.026470] Starting dynamic subtest: rcs0
[485.062840] Dynamic subtest rcs0: SUCCESS (2.036s)
[485.074054] Starting dynamic subtest: bcs0
[487.084744] Dynamic subtest bcs0: SUCCESS (2.020s)
[487.096209] Starting dynamic subtest: vcs0
[489.105099] Dynamic subtest vcs0: SUCCESS (2.019s)
[489.117032] Starting dynamic subtest: vcs1
[491.131745] Dynamic subtest vcs1: SUCCESS (2.018s)
[491.143130] Starting dynamic subtest: vecs0
[493.145990] Dynamic subtest vecs0: SUCCESS (2.021s)
[493.147606] Subtest u-fairslice: SUCCESS (10.121s)
[493.570741] [087/132] (541s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[495.576258] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[495.578930] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[495.841047] [088/132] (539s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[497.829900] Starting subtest: short-busy-flip-before-cursor-toggle
[497.833197] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[498.022629] [089/132] (537s left) gem_exec_whisper (basic-queues-all)
[498.081782] Starting subtest: basic-queues-all
[505.108513] Subtest basic-queues-all: SUCCESS (7.025s)
[505.427177] [090/132] (529s left) kms_busy (basic)
[507.422933] Starting subtest: basic
[507.424376] Starting dynamic subtest: flip
[508.076296] Dynamic subtest flip: SUCCESS (0.653s)
[508.087814] Starting dynamic subtest: modeset
[508.685939] Dynamic subtest modeset: SUCCESS (0.606s)
[508.687507] Subtest basic: SUCCESS (1.264s)
[508.912446] [091/132] (526s left) kms_writeback (writeback-check-output-xrgb2101010)
[510.897236] Subtest writeback-check-output-XRGB2101010: SKIP (0.000s)
[510.975058] [092/132] (524s left) kms_plane (plane-position-hole-dpms)
[512.962311] Starting subtest: plane-position-hole-dpms
[513.421132] Starting dynamic subtest: pipe-A-plane-1
[513.892663] Dynamic subtest pipe-A-plane-1: SUCCESS (0.472s)
[513.904144] Starting dynamic subtest: pipe-A-plane-2
[514.411040] Dynamic subtest pipe-A-plane-2: SUCCESS (0.517s)
[514.422277] Starting dynamic subtest: pipe-A-plane-3
[514.919991] Dynamic subtest pipe-A-plane-3: SUCCESS (0.507s)
[514.931406] Starting dynamic subtest: pipe-A-plane-4
[515.436637] Dynamic subtest pipe-A-plane-4: SUCCESS (0.516s)
[515.448049] Starting dynamic subtest: pipe-A-plane-5
[515.924871] Dynamic subtest pipe-A-plane-5: SUCCESS (0.487s)
[515.936252] Starting dynamic subtest: pipe-A-plane-6
[516.432300] Dynamic subtest pipe-A-plane-6: SUCCESS (0.506s)
[516.443576] Starting dynamic subtest: pipe-A-plane-7
[516.456691] Dynamic subtest pipe-A-plane-7: SUCCESS (0.022s)
[516.747432] Starting dynamic subtest: pipe-B-plane-1
[517.185738] Dynamic subtest pipe-B-plane-1: SUCCESS (0.451s)
[517.196870] Starting dynamic subtest: pipe-B-plane-2
[517.645056] Dynamic subtest pipe-B-plane-2: SUCCESS (0.456s)
[517.658281] Starting dynamic subtest: pipe-B-plane-3
[518.131588] Dynamic subtest pipe-B-plane-3: SUCCESS (0.486s)
[518.142974] Starting dynamic subtest: pipe-B-plane-4
[518.602099] Dynamic subtest pipe-B-plane-4: SUCCESS (0.469s)
[518.613381] Starting dynamic subtest: pipe-B-plane-5
[519.089095] Dynamic subtest pipe-B-plane-5: SUCCESS (0.486s)
[519.100408] Starting dynamic subtest: pipe-B-plane-6
[519.577649] Dynamic subtest pipe-B-plane-6: SUCCESS (0.486s)
[519.589025] Starting dynamic subtest: pipe-B-plane-7
[519.604965] Dynamic subtest pipe-B-plane-7: SUCCESS (0.024s)
[519.606641] Subtest plane-position-hole-dpms: SUCCESS (6.642s)
[519.856117] [093/132] (515s left) gem_exec_suspend (basic-s3)
[519.918943] Starting subtest: basic-S3
[519.920434] Starting dynamic subtest: smem
[544.201990] Dynamic subtest smem: SUCCESS (13.626s)
[544.214775] Starting dynamic subtest: lmem0
[569.192928] Dynamic subtest lmem0: SUCCESS (13.477s)
[569.194615] Subtest basic-S3: SUCCESS (27.106s)
[573.582778] [094/132] (465s left) gem_vm_create (isolation)
[573.634473] Starting subtest: isolation
[573.645655] Subtest isolation: SUCCESS (0.011s)
[573.818074] [095/132] (465s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[575.813203] Starting subtest: fbcpsr-indfb-scaledprimary
[575.816537] Subtest fbcpsr-indfb-scaledprimary: SKIP (0.000s)
[576.073665] [096/132] (463s left) panthor/panthor_vm (vm_destroy_invalid)
[576.182730] Subtest vm_destroy_invalid: SKIP (0.000s)
[576.355129] [097/132] (463s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[578.347717] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[578.350987] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[578.605836] [098/132] (461s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[580.616822] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[580.620074] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[580.872319] [099/132] (459s left) gem_lmem_swapping (smem-oom)
[585.116934] Starting subtest: smem-oom
[585.118499] Starting dynamic subtest: lmem0
[614.589108] Dynamic subtest lmem0: SUCCESS (29.469s)
[614.592957] Subtest smem-oom: SUCCESS (29.471s)
[616.851790] [FACT gem_lmem_swapping (smem-oom)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[616.855572] [FACT gem_lmem_swapping (smem-oom)] deleted: kernel.kmod_is_loaded.i915: true
[616.860753] [100/132] (423s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[622.994244] Starting subtest: async-flip-with-page-flip-events-tiled
[623.171191] Starting dynamic subtest: pipe-A-HDMI-A-4-y-rc-ccs
[625.485616] Dynamic subtest pipe-A-HDMI-A-4-y-rc-ccs: SUCCESS (2.310s)
[625.531141] Starting dynamic subtest: pipe-A-HDMI-A-4-y
[627.717328] Dynamic subtest pipe-A-HDMI-A-4-y: SUCCESS (2.224s)
[627.741892] Starting dynamic subtest: pipe-A-HDMI-A-4-y
[629.734196] Dynamic subtest pipe-A-HDMI-A-4-y: SUCCESS (2.009s)
[629.757635] Starting dynamic subtest: pipe-A-HDMI-A-4-x
[631.981837] Dynamic subtest pipe-A-HDMI-A-4-x: SUCCESS (2.242s)
[632.189407] Starting dynamic subtest: pipe-B-HDMI-A-4-y-rc-ccs
[634.431859] Dynamic subtest pipe-B-HDMI-A-4-y-rc-ccs: SUCCESS (2.248s)
[634.449754] Starting dynamic subtest: pipe-B-HDMI-A-4-y
[636.628317] Dynamic subtest pipe-B-HDMI-A-4-y: SUCCESS (2.190s)
[636.653134] Starting dynamic subtest: pipe-B-HDMI-A-4-y
[638.645424] Dynamic subtest pipe-B-HDMI-A-4-y: SUCCESS (2.009s)
[638.668293] Starting dynamic subtest: pipe-B-HDMI-A-4-x
[640.877829] Dynamic subtest pipe-B-HDMI-A-4-x: SUCCESS (2.225s)
[641.078952] Starting dynamic subtest: pipe-C-HDMI-A-4-y-rc-ccs
[643.335638] Dynamic subtest pipe-C-HDMI-A-4-y-rc-ccs: SUCCESS (2.266s)
[643.368406] Starting dynamic subtest: pipe-C-HDMI-A-4-y
[645.532344] Dynamic subtest pipe-C-HDMI-A-4-y: SUCCESS (2.195s)
[645.579151] Starting dynamic subtest: pipe-C-HDMI-A-4-y
[647.551931] Dynamic subtest pipe-C-HDMI-A-4-y: SUCCESS (2.009s)
[647.572013] Starting dynamic subtest: pipe-C-HDMI-A-4-x
[649.764501] Dynamic subtest pipe-C-HDMI-A-4-x: SUCCESS (2.208s)
[649.965716] Starting dynamic subtest: pipe-D-HDMI-A-4-y-rc-ccs
[652.216283] Dynamic subtest pipe-D-HDMI-A-4-y-rc-ccs: SUCCESS (2.258s)
[652.237275] Starting dynamic subtest: pipe-D-HDMI-A-4-y
[654.399267] Dynamic subtest pipe-D-HDMI-A-4-y: SUCCESS (2.175s)
[654.444700] Starting dynamic subtest: pipe-D-HDMI-A-4-y
[656.415481] Dynamic subtest pipe-D-HDMI-A-4-y: SUCCESS (2.009s)
[656.439600] Starting dynamic subtest: pipe-D-HDMI-A-4-x
[658.646547] Dynamic subtest pipe-D-HDMI-A-4-x: SUCCESS (2.225s)
[658.648507] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (35.650s)
[659.063182] [FACT kms_async_flips (async-flip-with-page-flip-events-tiled)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[659.066491] [FACT kms_async_flips (async-flip-with-page-flip-events-tiled)] new: kernel.kmod_is_loaded.i915: true
[659.070361] [101/132] (381s left) kms_feature_discovery (display)
[661.057458] Starting subtest: display
[661.059067] Subtest display: SUCCESS (0.000s)
[661.275780] [102/132] (379s left) gem_tiled_pread_basic
[661.408515] [103/132] (379s left) sysfs_timeslice_duration (idempotent)
[661.466648] Starting subtest: idempotent
[661.468478] Starting dynamic subtest: vecs0
[661.470222] Dynamic subtest vecs0: SUCCESS (0.001s)
[661.484594] Starting dynamic subtest: vcs0
[661.486515] Dynamic subtest vcs0: SUCCESS (0.001s)
[661.500309] Starting dynamic subtest: bcs0
[661.502329] Dynamic subtest bcs0: SUCCESS (0.001s)
[661.516119] Starting dynamic subtest: rcs0
[661.518103] Dynamic subtest rcs0: SUCCESS (0.001s)
[661.532058] Starting dynamic subtest: vcs1
[661.534187] Dynamic subtest vcs1: SUCCESS (0.001s)
[661.535688] Subtest idempotent: SUCCESS (0.011s)
[661.633710] [104/132] (379s left) gem_basic (multigpu-create-close)
[661.680411] Starting subtest: multigpu-create-close
[661.683371] Subtest multigpu-create-close: SKIP (0.000s)
[661.888828] [105/132] (378s left) gen9_exec_parse (bb-secure)
[661.942642] Subtest bb-secure: SKIP (0.000s)
[662.024740] [106/132] (378s left) gem_exec_suspend (basic-s0)
[662.082450] Starting subtest: basic-S0
[662.083929] Starting dynamic subtest: smem
[682.097989] Dynamic subtest smem: SUCCESS (5.463s)
[682.112201] Starting dynamic subtest: lmem0
[702.053347] Dynamic subtest lmem0: SUCCESS (5.303s)
[702.055211] Subtest basic-S0: SUCCESS (10.768s)
[708.367110] [107/132] (338s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[710.132526] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[710.136250] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[710.376919] [108/132] (336s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[712.391140] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[712.392826] Starting dynamic subtest: pipe-A-HDMI-A-4
[712.409269] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[712.423979] Starting dynamic subtest: pipe-B-HDMI-A-4
[712.440783] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[712.454784] Starting dynamic subtest: pipe-C-HDMI-A-4
[712.471905] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[712.486284] Starting dynamic subtest: pipe-D-HDMI-A-4
[712.513481] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[712.516387] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.010s)
[712.680686] [109/132] (334s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[714.694466] Starting subtest: x-tiled-8bpp-rotate-270
[714.804298] Subtest x-tiled-8bpp-rotate-270: SKIP (0.106s)
[715.060379] [110/132] (332s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[717.056996] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[717.059964] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[717.316902] [111/132] (330s left) kms_pm_rpm (modeset-non-lpsp-stress)
[722.420553] Starting subtest: modeset-non-lpsp-stress
[736.249850] Subtest modeset-non-lpsp-stress: SUCCESS (13.789s)
[737.419502] [112/132] (310s left) gem_mmap_gtt (hang-user)
[737.477238] Subtest hang-user: SKIP (0.000s)
[737.553575] [113/132] (310s left) kms_getfb (getfb2-accept-nv12)
[739.544578] Starting subtest: getfb2-accept-nv12
[739.546104] Subtest getfb2-accept-nv12: SUCCESS (0.002s)
[739.789667] [114/132] (307s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[741.784270] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[741.787225] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[742.051393] [115/132] (305s left) kms_plane_cursor (viewport)
[744.042443] Starting subtest: viewport
[744.045333] Starting dynamic subtest: pipe-A-HDMI-A-4-size-64
[747.574888] Dynamic subtest pipe-A-HDMI-A-4-size-64: SUCCESS (3.532s)
[747.658798] Starting dynamic subtest: pipe-A-HDMI-A-4-size-128
[751.142700] Dynamic subtest pipe-A-HDMI-A-4-size-128: SUCCESS (3.498s)
[751.227115] Starting dynamic subtest: pipe-A-HDMI-A-4-size-256
[754.710775] Dynamic subtest pipe-A-HDMI-A-4-size-256: SUCCESS (3.498s)
[754.853135] Starting dynamic subtest: pipe-B-HDMI-A-4-size-64
[758.415896] Dynamic subtest pipe-B-HDMI-A-4-size-64: SUCCESS (3.576s)
[758.498837] Starting dynamic subtest: pipe-B-HDMI-A-4-size-128
[762.016946] Dynamic subtest pipe-B-HDMI-A-4-size-128: SUCCESS (3.548s)
[762.097419] Starting dynamic subtest: pipe-B-HDMI-A-4-size-256
[765.602061] Dynamic subtest pipe-B-HDMI-A-4-size-256: SUCCESS (3.532s)
[765.713828] Starting dynamic subtest: pipe-C-HDMI-A-4-size-64
[769.280796] Dynamic subtest pipe-C-HDMI-A-4-size-64: SUCCESS (3.582s)
[769.367914] Starting dynamic subtest: pipe-C-HDMI-A-4-size-128
[772.865997] Dynamic subtest pipe-C-HDMI-A-4-size-128: SUCCESS (3.531s)
[772.931352] Starting dynamic subtest: pipe-C-HDMI-A-4-size-256
[776.400470] Dynamic subtest pipe-C-HDMI-A-4-size-256: SUCCESS (3.482s)
[776.506640] Starting dynamic subtest: pipe-D-HDMI-A-4-size-64
[780.028839] Dynamic subtest pipe-D-HDMI-A-4-size-64: SUCCESS (3.534s)
[780.095395] Starting dynamic subtest: pipe-D-HDMI-A-4-size-128
[783.596878] Dynamic subtest pipe-D-HDMI-A-4-size-128: SUCCESS (3.515s)
[783.675991] Starting dynamic subtest: pipe-D-HDMI-A-4-size-256
[787.182179] Dynamic subtest pipe-D-HDMI-A-4-size-256: SUCCESS (3.532s)
[787.260521] Subtest viewport: SUCCESS (43.202s)
[787.510827] [116/132] (260s left) kms_setmode (invalid-clone-single-crtc)
[787.560570] Starting subtest: invalid-clone-single-crtc
[787.565801] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[787.761222] [117/132] (260s left) gem_exec_reloc (basic-wc-noreloc)
[787.814124] Subtest basic-wc-noreloc: SKIP (0.000s)
[787.915716] [118/132] (260s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[789.906321] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[789.909216] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[790.164750] [119/132] (258s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[792.181598] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[792.183138] Starting dynamic subtest: pipe-A-HDMI-A-4
[792.198103] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.001s)
[792.212606] Starting dynamic subtest: pipe-B-HDMI-A-4
[792.228103] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.001s)
[792.242069] Starting dynamic subtest: pipe-C-HDMI-A-4
[792.257601] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.001s)
[792.271943] Starting dynamic subtest: pipe-D-HDMI-A-4
[792.288522] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.001s)
[792.291817] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SKIP (0.014s)
[792.506486] [120/132] (255s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[794.542738] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[794.659352] [121/132] (253s left) gem_mmap_wc (pf-nonblock)
[794.711751] Subtest pf-nonblock: SKIP (0.000s)
[794.789900] [122/132] (253s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[794.841787] Subtest writes-after-reads: SKIP (0.000s)
[794.933214] [123/132] (253s left) i915_power (sanity)
[794.979895] Starting subtest: sanity
[799.020792] Subtest sanity: SUCCESS (4.034s)
[799.232454] [124/132] (249s left) kms_flip (flip-vs-wf_vblank-interruptible)
[801.219030] Starting subtest: flip-vs-wf_vblank-interruptible
[801.227786] Starting dynamic subtest: A-HDMI-A4
[802.256170] Dynamic subtest A-HDMI-A4: SUCCESS (1.028s)
[802.282589] Starting dynamic subtest: B-HDMI-A4
[803.368540] Dynamic subtest B-HDMI-A4: SUCCESS (1.110s)
[803.386559] Starting dynamic subtest: C-HDMI-A4
[804.485390] Dynamic subtest C-HDMI-A4: SUCCESS (1.115s)
[804.500711] Starting dynamic subtest: D-HDMI-A4
[805.602152] Dynamic subtest D-HDMI-A4: SUCCESS (1.116s)
[805.603676] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (4.385s)
[805.899843] [125/132] (242s left) gem_ctx_freq (sysfs)
[805.954972] Starting subtest: sysfs
[805.956666] Starting dynamic subtest: gt0
[811.636389] Dynamic subtest gt0: SUCCESS (5.682s)
[811.646939] Subtest sysfs: SUCCESS (5.687s)
[811.882930] [126/132] (237s left) kms_rotation_crc (bad-pixel-format)
[813.872821] Starting subtest: bad-pixel-format
[816.011848] Subtest bad-pixel-format: SUCCESS (2.143s)
[816.271600] [127/132] (232s left) kms_cdclk (plane-scaling)
[816.322384] Subtest plane-scaling: SKIP (0.000s)
[816.398580] [128/132] (232s left) syncobj_wait (single-wait-for-submit-signaled)
[816.449812] Starting subtest: single-wait-for-submit-signaled
[816.451660] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[816.612749] [129/132] (232s left) api_intel_allocator (open-vm)
[816.661599] Starting subtest: open-vm
[816.674229] Subtest open-vm: SUCCESS (0.015s)
[816.902578] [130/132] (232s left) core_hotunplug (unbind-rebind)
[817.052262] Starting subtest: unbind-rebind
[822.226994] Subtest unbind-rebind: SUCCESS (5.178s)
[822.299362] [131/132] (227s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[822.354971] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[822.356759] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[822.559520] [132/132] (226s left) i915_pm_rpm (system-suspend-execbuf)
[827.427951] Starting subtest: system-suspend-execbuf
[889.679751] Subtest system-suspend-execbuf: SUCCESS (51.959s)
[890.892679] Closing watchdogs
results: parsing output: 0/ for test: kms_flip
results: parsing output: 1/ for test: kms_psr
results: parsing output: 2/ for test: syncobj_wait
results: parsing output: 3/ for test: kms_atomic
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: gem_ctx_param
results: parsing output: 6/ for test: api_intel_bb
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_joiner
results: parsing output: 9/ for test: kms_psr2_sf
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_rotation_crc
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_atomic_transition
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: kms_cursor_legacy
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: kms_joiner
results: parsing output: 18/ for test: kms_ccs
results: parsing output: 19/ for test: kms_cursor_crc
results: parsing output: 20/ for test: gem_exec_fence
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_flip
results: parsing output: 23/ for test: kms_addfb_basic
results: parsing output: 24/ for test: syncobj_timeline
results: parsing output: 25/ for test: gem_close_race
results: parsing output: 26/ for test: syncobj_wait
results: parsing output: 27/ for test: gem_exec_schedule
results: parsing output: 28/ for test: i915_drm_fdinfo
results: parsing output: 29/ for test: kms_psr
results: parsing output: 30/ for test: kms_plane_alpha_blend
results: parsing output: 31/ for test: kms_hdmi_inject
results: parsing output: 32/ for test: kms_psr2_sf
results: parsing output: 33/ for test: gem_exec_flush
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: gem_softpin
results: parsing output: 36/ for test: kms_flip_scaled_crc
results: parsing output: 37/ for test: gem_exec_gttfill
results: parsing output: 38/ for test: kms_flip
results: parsing output: 39/ for test: kms_cursor_legacy
results: parsing output: 40/ for test: gem_exec_fence
results: parsing output: 41/ for test: kms_chamelium_edid
results: parsing output: 42/ for test: kms_cursor_crc
results: parsing output: 43/ for test: kms_psr
results: parsing output: 44/ for test: kms_flip
results: parsing output: 45/ for test: gem_render_copy
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: gem_ctx_persistence
results: parsing output: 48/ for test: sriov_basic
results: parsing output: 49/ for test: kms_cursor_crc
results: parsing output: 50/ for test: gem_sync
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: gem_exec_reloc
results: parsing output: 54/ for test: kms_sharpness_filter
results: parsing output: 55/ for test: gem_create
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_eio
results: parsing output: 58/ for test: prime_mmap
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_rotation_crc
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: syncobj_wait
results: parsing output: 63/ for test: syncobj_timeline
results: parsing output: 64/ for test: kms_color
results: parsing output: 65/ for test: gem_pxp
results: parsing output: 66/ for test: perf_pmu
results: parsing output: 67/ for test: gem_exec_nop
results: parsing output: 68/ for test: kms_flip_scaled_crc
results: parsing output: 69/ for test: gem_eio
results: parsing output: 70/ for test: gem_exec_params
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_pm_dc
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_vblank
results: parsing output: 75/ for test: i915_hangman
results: parsing output: 76/ for test: gem_exec_balancer
results: parsing output: 77/ for test: gem_ctx_shared
results: parsing output: 78/ for test: kms_psr
results: parsing output: 79/ for test: syncobj_timeline
results: parsing output: 80/ for test: syncobj_basic
results: parsing output: 81/ for test: gem_eio
results: parsing output: 82/ for test: kms_plane_scaling
results: parsing output: 83/ for test: prime_vgem
results: parsing output: 84/ for test: gem_ctx_exec
results: parsing output: 85/ for test: gem_exec_schedule
results: parsing output: 86/ for test: kms_big_fb
results: parsing output: 87/ for test: kms_cursor_legacy
results: parsing output: 88/ for test: gem_exec_whisper
results: parsing output: 89/ for test: kms_busy
results: parsing output: 90/ for test: kms_writeback
results: parsing output: 91/ for test: kms_plane
results: parsing output: 92/ for test: gem_exec_suspend
results: parsing output: 93/ for test: gem_vm_create
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: panthor/panthor_vm
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: gem_lmem_swapping
results: parsing output: 99/ for test: kms_async_flips
results: parsing output: 100/ for test: kms_feature_discovery
results: parsing output: 101/ for test: gem_tiled_pread_basic
results: parsing output: 102/ for test: sysfs_timeslice_duration
results: parsing output: 103/ for test: gem_basic
results: parsing output: 104/ for test: gen9_exec_parse
results: parsing output: 105/ for test: gem_exec_suspend
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_pm_rpm
results: parsing output: 111/ for test: gem_mmap_gtt
results: parsing output: 112/ for test: kms_getfb
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_plane_cursor
results: parsing output: 115/ for test: kms_setmode
results: parsing output: 116/ for test: gem_exec_reloc
results: parsing output: 117/ for test: kms_ccs
results: parsing output: 118/ for test: kms_ccs
results: parsing output: 119/ for test: kms_chamelium_hpd
results: parsing output: 120/ for test: gem_mmap_wc
results: parsing output: 121/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 122/ for test: i915_power
results: parsing output: 123/ for test: kms_flip
results: parsing output: 124/ for test: gem_ctx_freq
results: parsing output: 125/ for test: kms_rotation_crc
results: parsing output: 126/ for test: kms_cdclk
results: parsing output: 127/ for test: syncobj_wait
results: parsing output: 128/ for test: api_intel_allocator
results: parsing output: 129/ for test: core_hotunplug
results: parsing output: 130/ for test: syncobj_timeline
results: parsing output: 131/ for test: i915_pm_rpm
Done.