[60.687021] Initializing watchdogs
[60.687111]   /dev/watchdog0
[60.706190] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[60.716794] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[60.720148] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.722609] [001/133] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[60.911418] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[60.913059] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[61.112951] [002/133] (960s left) gem_exec_suspend (basic-s3-devices)
[61.195180] Starting subtest: basic-S3-devices
[61.196107] Starting dynamic subtest: smem
[71.294052] Dynamic subtest smem: SUCCESS (10.131s)
[71.302850] Starting dynamic subtest: lmem0
[81.532430] Dynamic subtest lmem0: SUCCESS (10.238s)
[81.533453] Subtest basic-S3-devices: SUCCESS (20.369s)
[81.832251] [003/133] (939s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[81.908429] Starting subtest: y-tiled-ccs-to-yf-tiled
[81.910473] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[82.185946] [004/133] (939s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[82.359938] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[82.360874] Starting dynamic subtest: pipe-A-DP-3
[82.369280] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[82.377849] Starting dynamic subtest: pipe-B-DP-3
[82.386277] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[82.395606] Starting dynamic subtest: pipe-C-DP-3
[82.403833] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[82.412265] Starting dynamic subtest: pipe-D-DP-3
[82.422533] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[82.424451] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[82.838024] [005/133] (938s left) kms_flip (bo-too-big)
[83.016202] Starting subtest: bo-too-big
[83.020078] Starting dynamic subtest: A-DP3
[83.372102] Dynamic subtest A-DP3: SUCCESS (0.350s)
[83.409215] Starting dynamic subtest: B-DP3
[83.630072] Dynamic subtest B-DP3: SUCCESS (0.257s)
[83.641616] Starting dynamic subtest: C-DP3
[83.862539] Dynamic subtest C-DP3: SUCCESS (0.231s)
[83.887177] Starting dynamic subtest: D-DP3
[84.138436] Dynamic subtest D-DP3: SUCCESS (0.275s)
[84.141482] Subtest bo-too-big: SUCCESS (1.126s)
[84.578279] [006/133] (937s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[84.648911] Starting subtest: multi-wait-available-unsubmitted-signaled
[84.649833] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.001s)
[84.806683] [007/133] (936s left) kms_lease (lease-uevent)
[84.984918] Starting subtest: lease-uevent
[86.004847] Subtest lease-uevent: SUCCESS (1.020s)
[86.160323] [008/133] (935s left) gem_exec_fence (syncobj-timeline-wait)
[86.866046] Starting subtest: syncobj-timeline-wait
[87.009044] Subtest syncobj-timeline-wait: SUCCESS (0.145s)
[87.294518] [FACT gem_exec_fence (syncobj-timeline-wait)] new: kernel.kmod_is_loaded.vgem: true
[87.296156] [009/133] (934s left) kms_chamelium_color (gamma)
[87.487716] Subtest gamma: SKIP (0.000s)
[87.541627] [010/133] (934s left) prime_mmap (test_errors)
[87.618534] Starting subtest: test_errors
[87.619442] Starting dynamic subtest: test_errors-smem
[87.756073] Dynamic subtest test_errors-smem: SUCCESS (0.137s)
[87.765506] Starting dynamic subtest: test_errors-lmem0
[88.308573] Dynamic subtest test_errors-lmem0: SUCCESS (0.552s)
[88.309450] Subtest test_errors: SUCCESS (0.690s)
[88.457015] [011/133] (933s left) i915_drm_fdinfo (idle)
[88.527057] Starting subtest: idle
[88.528044] Starting dynamic subtest: rcs0
[89.112926] Dynamic subtest rcs0: SUCCESS (0.585s)
[89.125703] Starting dynamic subtest: bcs0
[89.619259] Dynamic subtest bcs0: SUCCESS (0.505s)
[89.629495] Starting dynamic subtest: vcs0
[90.125087] Dynamic subtest vcs0: SUCCESS (0.505s)
[90.135607] Starting dynamic subtest: vcs1
[90.630814] Dynamic subtest vcs1: SUCCESS (0.505s)
[90.641659] Starting dynamic subtest: vecs0
[91.136880] Dynamic subtest vecs0: SUCCESS (0.505s)
[91.147549] Starting dynamic subtest: vecs1
[91.642890] Dynamic subtest vecs1: SUCCESS (0.505s)
[91.653491] Starting dynamic subtest: ccs0
[92.148726] Dynamic subtest ccs0: SUCCESS (0.505s)
[92.150361] Subtest idle: SUCCESS (3.621s)
[92.296503] [012/133] (929s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[92.485466] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[92.487199] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[92.682519] [013/133] (929s left) kms_invalid_mode (zero-hdisplay)
[92.874052] Starting subtest: zero-hdisplay
[92.874988] Starting dynamic subtest: pipe-A-DP-3
[92.961127] Dynamic subtest pipe-A-DP-3: SUCCESS (0.088s)
[92.976393] Starting dynamic subtest: pipe-B-DP-3
[92.977526] Dynamic subtest pipe-B-DP-3: SUCCESS (0.001s)
[92.991394] Starting dynamic subtest: pipe-C-DP-3
[92.992441] Dynamic subtest pipe-C-DP-3: SUCCESS (0.001s)
[93.005445] Starting dynamic subtest: pipe-D-DP-3
[93.006412] Dynamic subtest pipe-D-DP-3: SUCCESS (0.001s)
[93.007350] Subtest zero-hdisplay: SUCCESS (0.096s)
[93.245934] [014/133] (928s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[93.436903] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[93.437703] Starting dynamic subtest: pipe-A
[93.527790] Dynamic subtest pipe-A: SUCCESS (0.091s)
[93.541359] Starting dynamic subtest: pipe-B
[93.741195] Dynamic subtest pipe-B: SUCCESS (0.213s)
[93.758677] Starting dynamic subtest: pipe-C
[93.974454] Dynamic subtest pipe-C: SUCCESS (0.233s)
[93.985076] Starting dynamic subtest: pipe-D
[94.186574] Dynamic subtest pipe-D: SUCCESS (0.212s)
[94.187386] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (0.750s)
[94.532494] [015/133] (927s left) drm_read (fault-buffer)
[94.782928] Starting subtest: fault-buffer
[94.783864] Subtest fault-buffer: SUCCESS (0.001s)
[95.066712] [016/133] (927s left) gem_ccs (suspend-resume)
[95.154372] Starting subtest: suspend-resume
[95.155286] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0
[113.546093] Dynamic subtest linear-compressed-compfmt0-smem-lmem0: SUCCESS (3.998s)
[113.557274] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0
[131.630641] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0: SUCCESS (3.717s)
[131.639954] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0
[149.495175] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0: SUCCESS (3.668s)
[149.504562] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0
[167.573612] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0: SUCCESS (3.645s)
[167.583085] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0
[185.537544] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0: SUCCESS (3.654s)
[185.546988] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0
[203.634875] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0: SUCCESS (3.767s)
[203.644431] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0
[221.536873] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0: SUCCESS (3.703s)
[221.546239] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0
[239.625942] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0: SUCCESS (3.763s)
[239.626891] Subtest suspend-resume: SUCCESS (29.918s)
[239.835819] [017/133] (782s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[240.014227] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[240.015110] Starting dynamic subtest: pipe-A-DP-3
[240.022973] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[240.032144] Starting dynamic subtest: pipe-B-DP-3
[240.039984] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[240.049114] Starting dynamic subtest: pipe-C-DP-3
[240.056949] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[240.066050] Starting dynamic subtest: pipe-D-DP-3
[240.075697] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[240.077510] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[240.488584] [018/133] (781s left) gem_close (many-handles-one-vma)
[240.567764] Starting subtest: many-handles-one-vma
[240.596052] Subtest many-handles-one-vma: SUCCESS (0.029s)
[240.761450] [019/133] (781s left) gem_busy (extended)
[241.026291] Starting subtest: extended
[241.027168] Starting dynamic subtest: rcs0
[241.115598] Dynamic subtest rcs0: SUCCESS (0.092s)
[241.147591] Starting dynamic subtest: bcs0
[241.164915] Dynamic subtest bcs0: SUCCESS (0.049s)
[241.192481] Starting dynamic subtest: vcs0
[241.214045] Dynamic subtest vcs0: SUCCESS (0.050s)
[241.228144] Starting dynamic subtest: vcs1
[241.254967] Dynamic subtest vcs1: SUCCESS (0.041s)
[241.272721] Starting dynamic subtest: vecs0
[241.297360] Dynamic subtest vecs0: SUCCESS (0.043s)
[241.317621] Starting dynamic subtest: vecs1
[241.341366] Dynamic subtest vecs1: SUCCESS (0.044s)
[241.361618] Starting dynamic subtest: ccs0
[241.385133] Dynamic subtest ccs0: SUCCESS (0.044s)
[241.386208] Subtest extended: SUCCESS (0.370s)
[241.668670] [020/133] (780s left) kms_vblank (ts-continuation-suspend)
[241.846758] Starting subtest: ts-continuation-suspend
[241.847661] Starting dynamic subtest: pipe-A-DP-3
[261.582018] Dynamic subtest pipe-A-DP-3: SUCCESS (3.909s)
[261.594766] Starting dynamic subtest: pipe-D-DP-3
[280.981987] Dynamic subtest pipe-D-DP-3: SUCCESS (3.763s)
[280.982844] Subtest ts-continuation-suspend: SUCCESS (7.676s)
[281.271254] [021/133] (741s left) perf_pmu (semaphore-wait-idle)
[281.351105] Starting subtest: semaphore-wait-idle
[281.352041] Starting dynamic subtest: rcs0
[281.890007] Dynamic subtest rcs0: SUCCESS (0.538s)
[281.903817] Starting dynamic subtest: bcs0
[282.403995] Dynamic subtest bcs0: SUCCESS (0.512s)
[282.417400] Starting dynamic subtest: vcs0
[282.916345] Dynamic subtest vcs0: SUCCESS (0.511s)
[282.930489] Starting dynamic subtest: vcs1
[283.429312] Dynamic subtest vcs1: SUCCESS (0.511s)
[283.442872] Starting dynamic subtest: vecs0
[283.942004] Dynamic subtest vecs0: SUCCESS (0.511s)
[283.955673] Starting dynamic subtest: vecs1
[284.454903] Dynamic subtest vecs1: SUCCESS (0.511s)
[284.468484] Starting dynamic subtest: ccs0
[284.966436] Dynamic subtest ccs0: SUCCESS (0.510s)
[284.967326] Subtest semaphore-wait-idle: SUCCESS (3.617s)
[285.199943] [022/133] (737s left) kms_debugfs (display-off-read-all)
[285.399199] Starting subtest: display-off-read-all
[285.481763] Subtest display-off-read-all: SUCCESS (0.082s)
[285.737393] [023/133] (737s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[285.926546] Starting subtest: fbc-rgb101010-draw-blt
[288.801795] Subtest fbc-rgb101010-draw-blt: SUCCESS (2.877s)
[288.999036] [024/133] (733s left) gem_ctx_param (invalid-get-no-zeromap)
[289.072098] Starting subtest: invalid-get-no-zeromap
[289.074041] Subtest invalid-get-no-zeromap: SUCCESS (0.002s)
[289.268070] [025/133] (733s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[289.460152] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[289.461822] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[289.661421] [026/133] (733s left) gem_exec_big (single)
[289.743340] Starting subtest: single
[295.286788] Subtest single: SUCCESS (5.546s)
[296.005748] [027/133] (727s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[296.279549] Starting subtest: psr-rgb101010-draw-mmap-gtt
[296.281166] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[296.445447] [028/133] (726s left) gem_exec_flush (basic-uc-prw-default)
[296.527170] Subtest basic-uc-prw-default: SKIP (0.000s)
[296.605354] [029/133] (726s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[296.813244] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[296.814944] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[296.976191] [030/133] (726s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[297.183244] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[297.184920] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[297.376293] [031/133] (725s left) gem_exec_create (forked)
[297.504681] Starting subtest: forked
[297.505608] Starting dynamic subtest: smem
[317.639286] Dynamic subtest smem: SUCCESS (20.141s)
[317.657776] Starting dynamic subtest: lmem0
[337.795203] Dynamic subtest lmem0: SUCCESS (20.160s)
[337.796208] Subtest forked: SUCCESS (40.303s)
[338.087350] [032/133] (685s left) kms_feature_discovery (display-1x)
[338.278818] Starting subtest: display-1x
[338.279776] Subtest display-1x: SUCCESS (0.000s)
[338.439082] [033/133] (684s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[338.639239] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[338.640882] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[338.833248] [034/133] (684s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[339.024330] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[339.026034] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[339.219077] [035/133] (684s left) gem_render_copy_redux (interruptible)
[339.302888] Starting subtest: interruptible
[340.049297] Subtest interruptible: SUCCESS (0.747s)
[340.231474] [036/133] (683s left) i915_pm_rpm (system-suspend-execbuf)
[342.678291] Starting subtest: system-suspend-execbuf
[403.264398] Subtest system-suspend-execbuf: SUCCESS (45.063s)
[403.678963] [037/133] (620s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[403.872330] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[403.874022] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[404.069990] [038/133] (619s left) gem_request_retire (retire-vma-not-inactive)
[404.152010] Starting subtest: retire-vma-not-inactive
[404.235375] Subtest retire-vma-not-inactive: SUCCESS (0.083s)
[404.469115] [039/133] (619s left) i915_pm_rps (thresholds-idle)
[404.554964] Starting subtest: thresholds-idle
[404.556778] Subtest thresholds-idle: SKIP (0.000s)
[404.728518] [040/133] (619s left) gem_ctx_persistence (legacy-engines-queued)
[404.812817] Starting subtest: legacy-engines-queued
[404.813741] Starting dynamic subtest: render
[404.918143] Dynamic subtest render: SUCCESS (0.105s)
[404.932130] Starting dynamic subtest: bsd1
[404.961855] Dynamic subtest bsd1: SUCCESS (0.043s)
[404.976835] Starting dynamic subtest: bsd2
[405.011097] Dynamic subtest bsd2: SUCCESS (0.048s)
[405.035408] Starting dynamic subtest: blt
[405.044118] Dynamic subtest blt: SUCCESS (0.032s)
[405.067095] Starting dynamic subtest: vebox
[405.094979] Dynamic subtest vebox: SUCCESS (0.050s)
[405.095969] Subtest legacy-engines-queued: SUCCESS (0.282s)
[405.320190] [041/133] (618s left) i915_hangman (gt-error-state-capture)
[405.411587] Starting subtest: gt-error-state-capture
[405.412479] Starting dynamic subtest: rcs0
[415.356663] Dynamic subtest rcs0: SUCCESS (9.946s)
[415.369853] Starting dynamic subtest: bcs0
[425.273625] Dynamic subtest bcs0: SUCCESS (9.919s)
[425.286994] Starting dynamic subtest: vcs0
[435.297107] Dynamic subtest vcs0: SUCCESS (10.022s)
[435.310584] Starting dynamic subtest: vcs1
[445.281063] Dynamic subtest vcs1: SUCCESS (9.983s)
[445.294543] Starting dynamic subtest: vecs0
[455.260133] Dynamic subtest vecs0: SUCCESS (9.980s)
[455.273603] Starting dynamic subtest: vecs1
[465.311509] Dynamic subtest vecs1: SUCCESS (10.053s)
[465.324817] Starting dynamic subtest: ccs0
[475.322206] Dynamic subtest ccs0: SUCCESS (10.013s)
[475.323199] Subtest gt-error-state-capture: SUCCESS (69.921s)
[475.546410] [042/133] (548s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[475.934893] Starting subtest: cursor-rapid-movement-128x42
[475.939184] Starting dynamic subtest: pipe-A-DP-3
[476.405883] Dynamic subtest pipe-A-DP-3: SUCCESS (0.466s)
[476.458234] Starting dynamic subtest: pipe-D-DP-3
[476.833789] Dynamic subtest pipe-D-DP-3: SUCCESS (0.388s)
[476.834814] Subtest cursor-rapid-movement-128x42: SUCCESS (0.899s)
[477.294903] [043/133] (546s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[477.377846] Subtest writes-after-reads-uncached: SKIP (0.000s)
[477.468530] [044/133] (546s left) gem_mmap_wc (coherency)
[477.543852] Subtest coherency: SKIP (0.000s)
[477.613653] [045/133] (546s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[477.700106] Starting subtest: single-wait-all-for-submit-signaled
[477.701072] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[477.839416] [046/133] (546s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[478.028430] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[480.584399] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (2.558s)
[480.817153] [047/133] (543s left) kms_psr (fbc-psr-primary-mmap-cpu)
[481.003174] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.000s)
[481.062605] [048/133] (543s left) kms_invalid_mode (bad-vsync-start)
[481.248783] Starting subtest: bad-vsync-start
[481.249738] Starting dynamic subtest: pipe-A-DP-3
[481.324291] Dynamic subtest pipe-A-DP-3: SUCCESS (0.075s)
[481.341233] Starting dynamic subtest: pipe-B-DP-3
[481.342444] Dynamic subtest pipe-B-DP-3: SUCCESS (0.001s)
[481.357381] Starting dynamic subtest: pipe-C-DP-3
[481.358286] Dynamic subtest pipe-C-DP-3: SUCCESS (0.001s)
[481.372258] Starting dynamic subtest: pipe-D-DP-3
[481.373146] Dynamic subtest pipe-D-DP-3: SUCCESS (0.001s)
[481.374005] Subtest bad-vsync-start: SUCCESS (0.083s)
[481.613097] [049/133] (542s left) gem_exec_reloc (basic-wc-gtt)
[481.696180] Subtest basic-wc-gtt: SKIP (0.000s)
[481.768169] [050/133] (542s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[481.842764] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[481.922450] [051/133] (542s left) kms_prop_blob (blob-multiple)
[481.997839] Starting subtest: blob-multiple
[482.029860] Subtest blob-multiple: SUCCESS (0.032s)
[482.240575] [052/133] (542s left) api_intel_allocator (open-vm)
[482.314882] Starting subtest: open-vm
[482.341151] Subtest open-vm: SUCCESS (0.026s)
[482.556700] [053/133] (542s left) kms_getfb (getfb-repeated-different-handles)
[482.740907] Starting subtest: getfb-repeated-different-handles
[482.741829] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[482.974322] [054/133] (542s left) kms_content_protection (legacy-hdcp14)
[483.223955] Starting subtest: legacy-hdcp14
[483.509015] Starting dynamic subtest: pipe-A-DP-3
[604.844064] Dynamic subtest pipe-A-DP-3: FAIL (121.054s)
[604.845092] Subtest legacy-hdcp14: FAIL (121.448s)
[605.008143] [055/133] (420s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[605.263247] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[605.408558] [056/133] (419s left) kms_flip (blocking-absolute-wf_vblank)
[605.591192] Starting subtest: blocking-absolute-wf_vblank
[605.595629] Starting dynamic subtest: A-DP3
[613.432120] Dynamic subtest A-DP3: SUCCESS (7.835s)
[613.448702] Starting dynamic subtest: B-DP3
[621.201849] Dynamic subtest B-DP3: SUCCESS (7.768s)
[621.217606] Starting dynamic subtest: C-DP3
[628.972148] Dynamic subtest C-DP3: SUCCESS (7.769s)
[628.987689] Starting dynamic subtest: D-DP3
[636.739744] Dynamic subtest D-DP3: SUCCESS (7.767s)
[636.741944] Subtest blocking-absolute-wf_vblank: SUCCESS (31.149s)
[637.122487] [057/133] (388s left) gem_mmap_offset (bad-object)
[637.200001] Starting subtest: bad-object
[637.200927] Subtest bad-object: SUCCESS (0.000s)
[637.368309] [058/133] (387s left) kms_psr (psr2-no-drrs)
[637.552858] Subtest psr2-no-drrs: SKIP (0.000s)
[637.613562] [059/133] (387s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[637.701471] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[637.783993] [060/133] (387s left) kms_vblank (wait-idle)
[637.967343] Starting subtest: wait-idle
[637.969491] Starting dynamic subtest: pipe-A-DP-3
[640.278976] Dynamic subtest pipe-A-DP-3: SUCCESS (2.310s)
[640.305234] Starting dynamic subtest: pipe-D-DP-3
[642.547917] Dynamic subtest pipe-D-DP-3: SUCCESS (2.263s)
[642.548929] Subtest wait-idle: SUCCESS (4.580s)
[642.842422] [061/133] (382s left) gem_exec_whisper (basic-contexts-all)
[642.930180] Starting subtest: basic-contexts-all
[664.954671] Subtest basic-contexts-all: SUCCESS (22.025s)
[665.242317] [062/133] (360s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[665.439640] Starting subtest: x-tiled-16bpp-rotate-0
[667.185111] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.745s)
[667.454614] [063/133] (358s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[667.638490] Starting subtest: plane-primary-overlay-mutable-zpos
[669.780930] Subtest plane-primary-overlay-mutable-zpos: SKIP (2.141s)
[670.146495] [064/133] (355s left) gen9_exec_parse (bb-start-cmd)
[670.226967] Subtest bb-start-cmd: SKIP (0.000s)
[670.317592] [065/133] (355s left) kms_cursor_crc (cursor-alpha-opaque)
[670.507253] Starting subtest: cursor-alpha-opaque
[670.509633] Starting dynamic subtest: pipe-A-DP-3
[671.118988] Dynamic subtest pipe-A-DP-3: SUCCESS (0.609s)
[671.146293] Starting dynamic subtest: pipe-D-DP-3
[671.623700] Dynamic subtest pipe-D-DP-3: SUCCESS (0.502s)
[671.624704] Subtest cursor-alpha-opaque: SUCCESS (1.117s)
[672.308188] [066/133] (353s left) kms_cursor_crc (cursor-sliding-64x64)
[672.634096] Starting subtest: cursor-sliding-64x64
[672.638917] Starting dynamic subtest: pipe-A-DP-3
[677.004984] Dynamic subtest pipe-A-DP-3: SUCCESS (4.367s)
[677.055138] Starting dynamic subtest: pipe-D-DP-3
[681.346865] Dynamic subtest pipe-D-DP-3: SUCCESS (4.305s)
[681.347747] Subtest cursor-sliding-64x64: SUCCESS (8.713s)
[681.904483] [067/133] (344s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[682.095801] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[682.097630] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[682.312350] [068/133] (343s left) gem_ctx_shared (exec-single-timeline)
[682.399910] Starting subtest: exec-single-timeline
[682.400807] Starting dynamic subtest: rcs0
[683.503372] Dynamic subtest rcs0: SUCCESS (1.102s)
[683.521201] Starting dynamic subtest: bcs0
[684.527827] Dynamic subtest bcs0: SUCCESS (1.020s)
[684.546496] Starting dynamic subtest: vcs0
[685.614906] Dynamic subtest vcs0: SUCCESS (1.082s)
[685.632859] Starting dynamic subtest: vcs1
[686.638833] Dynamic subtest vcs1: SUCCESS (1.019s)
[686.657180] Starting dynamic subtest: vecs0
[687.663129] Dynamic subtest vecs0: SUCCESS (1.019s)
[687.712305] Starting dynamic subtest: vecs1
[688.750914] Dynamic subtest vecs1: SUCCESS (1.082s)
[688.768473] Starting dynamic subtest: ccs0
[689.774859] Dynamic subtest ccs0: SUCCESS (1.019s)
[689.779172] Subtest exec-single-timeline: SUCCESS (7.375s)
[690.112264] [069/133] (336s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[690.295313] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[690.296162] Starting dynamic subtest: pipe-A
[692.342142] Dynamic subtest pipe-A: SUCCESS (2.046s)
[692.369937] Starting dynamic subtest: pipe-B
[694.473193] Dynamic subtest pipe-B: SUCCESS (2.128s)
[694.506750] Starting dynamic subtest: pipe-C
[694.785792] Dynamic subtest pipe-C: SUCCESS (0.310s)
[694.814602] Starting dynamic subtest: pipe-D
[695.097524] Dynamic subtest pipe-D: SUCCESS (0.310s)
[695.098489] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (4.802s)
[695.411942] [070/133] (330s left) gem_wait (write-busy)
[695.503718] Starting subtest: write-busy
[695.504668] Starting dynamic subtest: all-engines
[696.118090] Dynamic subtest all-engines: SUCCESS (0.614s)
[696.136468] Starting dynamic subtest: rcs0
[696.669721] Dynamic subtest rcs0: SUCCESS (0.550s)
[696.683909] Starting dynamic subtest: bcs0
[697.214834] Dynamic subtest bcs0: SUCCESS (0.544s)
[697.230478] Starting dynamic subtest: vcs0
[697.758830] Dynamic subtest vcs0: SUCCESS (0.543s)
[697.774441] Starting dynamic subtest: vcs1
[698.302962] Dynamic subtest vcs1: SUCCESS (0.543s)
[698.318783] Starting dynamic subtest: vecs0
[698.846838] Dynamic subtest vecs0: SUCCESS (0.543s)
[698.861129] Starting dynamic subtest: vecs1
[699.388846] Dynamic subtest vecs1: SUCCESS (0.541s)
[699.403303] Starting dynamic subtest: ccs0
[699.930796] Dynamic subtest ccs0: SUCCESS (0.541s)
[699.931714] Subtest write-busy: SUCCESS (4.427s)
[700.227847] [071/133] (326s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[700.424140] Starting subtest: y-tiled-8bpp-rotate-0
[700.425904] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[700.630223] [072/133] (325s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[700.815020] Starting subtest: basic-busy-flip-before-cursor-legacy
[700.816846] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[700.980295] [073/133] (325s left) gem_basic (bad-close)
[701.060094] Starting subtest: bad-close
[701.061780] Subtest bad-close: SUCCESS (0.000s)
[701.263217] [074/133] (325s left) kms_big_fb (linear-16bpp-rotate-0)
[701.467151] Starting subtest: linear-16bpp-rotate-0
[703.330311] Subtest linear-16bpp-rotate-0: SUCCESS (1.861s)
[703.536290] [075/133] (323s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf)
[703.735894] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[703.792377] [076/133] (322s left) drm_read (short-buffer-wakeup)
[704.046385] Starting subtest: short-buffer-wakeup
[736.263875] Subtest short-buffer-wakeup: SUCCESS (32.213s)
[736.493351] [077/133] (290s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[736.690855] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[736.692579] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s)
[736.882790] [078/133] (289s left) kms_psr (fbc-pr-cursor-render)
[737.066161] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[737.131533] [079/133] (289s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[737.317555] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[737.319974] Starting dynamic subtest: pipe-A-DP-3
[737.323341] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[737.337238] Starting dynamic subtest: pipe-B-DP-3
[737.340745] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[737.354416] Starting dynamic subtest: pipe-C-DP-3
[737.357707] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[737.371205] Starting dynamic subtest: pipe-D-DP-3
[737.375291] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[737.377242] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.007s)
[737.813788] [080/133] (289s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[738.008276] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[738.009172] Starting dynamic subtest: pipe-A-DP-3
[738.018531] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[738.032106] Starting dynamic subtest: pipe-B-DP-3
[738.041199] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[738.054591] Starting dynamic subtest: pipe-C-DP-3
[738.063588] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[738.077217] Starting dynamic subtest: pipe-D-DP-3
[738.088643] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[738.091087] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SKIP (0.007s)
[738.493321] [081/133] (288s left) sw_sync (sync_multi_timeline_wait)
[738.541685] Starting subtest: sync_multi_timeline_wait
[738.542582] Subtest sync_multi_timeline_wait: SUCCESS (0.001s)
[738.665368] [082/133] (288s left) sysfs_heartbeat_interval (idempotent)
[738.754551] Starting subtest: idempotent
[738.756964] Starting dynamic subtest: vecs0
[738.758019] Dynamic subtest vecs0: SUCCESS (0.001s)
[738.772297] Starting dynamic subtest: ccs0
[738.773654] Dynamic subtest ccs0: SUCCESS (0.001s)
[738.787505] Starting dynamic subtest: vcs0
[738.788639] Dynamic subtest vcs0: SUCCESS (0.001s)
[738.802518] Starting dynamic subtest: bcs0
[738.803609] Dynamic subtest bcs0: SUCCESS (0.001s)
[738.817366] Starting dynamic subtest: vecs1
[738.818508] Dynamic subtest vecs1: SUCCESS (0.001s)
[738.831930] Starting dynamic subtest: rcs0
[738.833172] Dynamic subtest rcs0: SUCCESS (0.001s)
[738.846666] Starting dynamic subtest: vcs1
[738.847940] Dynamic subtest vcs1: SUCCESS (0.001s)
[738.849052] Subtest idempotent: SUCCESS (0.016s)
[738.907702] [083/133] (288s left) syncobj_eventfd (invalid-bad-pad)
[738.984239] Starting subtest: invalid-bad-pad
[738.985310] Subtest invalid-bad-pad: SUCCESS (0.000s)
[739.158967] [084/133] (288s left) kms_busy (extended-pageflip-hang-newfb)
[739.349405] Starting subtest: extended-pageflip-hang-newfb
[739.351718] Starting dynamic subtest: pipe-A
[747.233878] Dynamic subtest pipe-A: SUCCESS (7.882s)
[747.255608] Starting dynamic subtest: pipe-D
[755.129202] Dynamic subtest pipe-D: SUCCESS (7.891s)
[755.131637] Subtest extended-pageflip-hang-newfb: SUCCESS (15.780s)
[755.420824] [085/133] (271s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[755.609687] Subtest psr2-cursor-plane-update-sf: SKIP (0.000s)
[755.664373] [086/133] (271s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[755.860119] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[756.583821] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.723s)
[756.839112] [087/133] (270s left) gem_exec_balancer (busy)
[756.926226] Starting subtest: busy
[757.791809] Subtest busy: SUCCESS (0.866s)
[758.236659] [088/133] (269s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[758.424774] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[758.426487] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[758.620162] [089/133] (268s left) vgem_slow (nohang)
[758.684133] Starting subtest: nohang
[769.007580] Subtest nohang: SUCCESS (10.323s)
[769.138186] [090/133] (258s left) gem_spin_batch (resubmit-new-all)
[769.227893] Starting subtest: resubmit-new-all
[769.228857] Starting dynamic subtest: rcs0
[769.266484] Dynamic subtest rcs0: SUCCESS (0.038s)
[769.282585] Starting dynamic subtest: bcs0
[769.283568] Dynamic subtest bcs0: SUCCESS (0.009s)
[769.297799] Starting dynamic subtest: vcs0
[769.298750] Dynamic subtest vcs0: SUCCESS (0.008s)
[769.312733] Starting dynamic subtest: vcs1
[769.313672] Dynamic subtest vcs1: SUCCESS (0.011s)
[769.327367] Starting dynamic subtest: vecs0
[769.328272] Dynamic subtest vecs0: SUCCESS (0.009s)
[769.342968] Starting dynamic subtest: vecs1
[769.344204] Dynamic subtest vecs1: SUCCESS (0.008s)
[769.357823] Starting dynamic subtest: ccs0
[769.358866] Dynamic subtest ccs0: SUCCESS (0.009s)
[769.359910] Subtest resubmit-new-all: SUCCESS (0.100s)
[769.658786] [091/133] (258s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[769.740261] Starting subtest: mixed-tiled-to-y-tiled-ccs
[769.742366] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[770.037125] [092/133] (257s left) syncobj_timeline (invalid-signal-illegal-point)
[770.111113] Starting subtest: invalid-signal-illegal-point
[770.112020] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[770.323286] [093/133] (257s left) gem_exec_schedule (preempt-contexts)
[770.415491] Starting subtest: preempt-contexts
[770.416375] Starting dynamic subtest: rcs0
[770.517121] Dynamic subtest rcs0: SUCCESS (0.101s)
[770.532980] Starting dynamic subtest: bcs0
[770.593304] Dynamic subtest bcs0: SUCCESS (0.075s)
[770.608868] Starting dynamic subtest: vcs0
[770.668586] Dynamic subtest vcs0: SUCCESS (0.074s)
[770.683900] Starting dynamic subtest: vcs1
[770.741105] Dynamic subtest vcs1: SUCCESS (0.071s)
[770.756848] Starting dynamic subtest: vecs0
[770.814986] Dynamic subtest vecs0: SUCCESS (0.073s)
[770.830324] Starting dynamic subtest: vecs1
[770.888128] Dynamic subtest vecs1: SUCCESS (0.072s)
[770.903773] Starting dynamic subtest: ccs0
[770.962093] Dynamic subtest ccs0: SUCCESS (0.073s)
[770.963104] Subtest preempt-contexts: SUCCESS (0.547s)
[771.533403] [094/133] (256s left) gem_pwrite_snooped
[771.700328] [095/133] (256s left) kms_tiled_display (basic-test-pattern)
[771.958112] Subtest basic-test-pattern: SKIP (0.000s)
[772.030132] [096/133] (256s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[772.221017] Starting subtest: psr-shrfb-scaledprimary
[772.222720] Subtest psr-shrfb-scaledprimary: SKIP (0.000s)
[772.421237] [097/133] (255s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[772.614779] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[772.616455] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[772.834640] [098/133] (255s left) gem_pwrite (basic-self)
[772.911908] Subtest basic-self: SKIP (0.000s)
[772.980954] [099/133] (255s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[775.285677] Starting subtest: dpms-mode-unset-non-lpsp
[776.699020] Subtest dpms-mode-unset-non-lpsp: SUCCESS (1.413s)
[777.186502] [100/133] (251s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[777.378915] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[777.380719] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[777.592810] [101/133] (250s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[777.782678] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[777.784395] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[777.994429] [102/133] (250s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[778.183996] Starting subtest: plane-lut1d-ctm3x4-lut1d
[778.210142] Starting dynamic subtest: pipe-A-DP-3
[778.609109] Dynamic subtest pipe-A-DP-3: SUCCESS (0.399s)
[778.804117] Starting dynamic subtest: pipe-B-DP-3
[779.152273] Dynamic subtest pipe-B-DP-3: SUCCESS (0.365s)
[779.353141] Starting dynamic subtest: pipe-C-DP-3
[779.687109] Dynamic subtest pipe-C-DP-3: SUCCESS (0.348s)
[779.854184] Starting dynamic subtest: pipe-D-DP-3
[780.185544] Dynamic subtest pipe-D-DP-3: SUCCESS (0.348s)
[780.244958] Subtest plane-lut1d-ctm3x4-lut1d: SUCCESS (2.061s)
[780.561540] [103/133] (248s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[780.748856] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[780.750592] Subtest psr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[780.946236] [104/133] (247s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[781.144764] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[781.146635] Subtest psr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[781.349387] [105/133] (247s left) gem_exec_schedule (preempt-queue-contexts-chain)
[781.440327] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[781.862383] [106/133] (247s left) api_intel_bb (object-noreloc-keep-cache-simple)
[781.943427] Starting subtest: object-noreloc-keep-cache-simple
[781.970433] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.028s)
[782.217206] [107/133] (246s left) gem_mmap (bad-object)
[782.293223] Subtest bad-object: SKIP (0.000s)
[782.372777] [108/133] (246s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[782.561996] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[782.562888] Starting dynamic subtest: pipe-A-valid-mode
[782.655138] Dynamic subtest pipe-A-valid-mode: SKIP (0.090s)
[782.657075] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.092s)
[782.919978] [109/133] (246s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[783.110036] Starting subtest: bo-too-small-due-to-tiling
[783.111778] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[783.317612] [110/133] (245s left) kms_psr (pr-sprite-blt)
[783.502172] Subtest pr-sprite-blt: SKIP (0.000s)
[783.607627] [111/133] (245s left) kms_draw_crc (fill-fb)
[783.791134] Starting subtest: fill-fb
[784.313341] Subtest fill-fb: SUCCESS (0.523s)
[784.534671] [112/133] (244s left) perf_pmu (busy-idle)
[784.605021] Starting subtest: busy-idle
[784.605943] Starting dynamic subtest: rcs0
[785.334386] Dynamic subtest rcs0: SUCCESS (0.728s)
[785.354266] Starting dynamic subtest: bcs0
[786.004391] Dynamic subtest bcs0: SUCCESS (0.665s)
[786.022099] Starting dynamic subtest: vcs0
[786.669366] Dynamic subtest vcs0: SUCCESS (0.660s)
[786.689357] Starting dynamic subtest: vcs1
[787.337262] Dynamic subtest vcs1: SUCCESS (0.663s)
[787.355459] Starting dynamic subtest: vecs0
[788.005339] Dynamic subtest vecs0: SUCCESS (0.663s)
[788.025895] Starting dynamic subtest: vecs1
[788.677319] Dynamic subtest vecs1: SUCCESS (0.667s)
[788.700891] Starting dynamic subtest: ccs0
[789.347259] Dynamic subtest ccs0: SUCCESS (0.665s)
[789.353509] Subtest busy-idle: SUCCESS (4.745s)
[789.567360] [113/133] (239s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[789.749367] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[789.751879] Starting dynamic subtest: pipe-A-DP-3
[789.773431] Dynamic subtest pipe-A-DP-3: SKIP (0.002s)
[789.787706] Starting dynamic subtest: pipe-B-DP-3
[789.808978] Dynamic subtest pipe-B-DP-3: SKIP (0.002s)
[789.823287] Starting dynamic subtest: pipe-C-DP-3
[789.851119] Dynamic subtest pipe-C-DP-3: SKIP (0.002s)
[789.865599] Starting dynamic subtest: pipe-D-DP-3
[789.892097] Dynamic subtest pipe-D-DP-3: SKIP (0.002s)
[789.894046] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.015s)
[790.226006] [114/133] (239s left) gem_exec_flush (basic-batch-kernel-default-uc)
[790.312853] Subtest basic-batch-kernel-default-uc: SKIP (0.000s)
[790.408213] [115/133] (239s left) gem_mmap_wc (write-read-distinct)
[790.483916] Subtest write-read-distinct: SKIP (0.000s)
[790.553077] [116/133] (239s left) kms_plane_lowres (tiling-x)
[790.737143] Starting subtest: tiling-x
[790.738031] Starting dynamic subtest: pipe-A-DP-3
[801.346864] Dynamic subtest pipe-A-DP-3: SUCCESS (10.609s)
[801.467157] Starting dynamic subtest: pipe-B-DP-3
[811.802698] Dynamic subtest pipe-B-DP-3: SUCCESS (10.349s)
[811.907884] Starting dynamic subtest: pipe-C-DP-3
[822.281691] Dynamic subtest pipe-C-DP-3: SUCCESS (10.388s)
[822.385897] Starting dynamic subtest: pipe-D-DP-3
[832.903630] Dynamic subtest pipe-D-DP-3: SUCCESS (10.532s)
[833.009483] Subtest tiling-x: SUCCESS (42.277s)
[833.337648] [117/133] (196s left) sw_sync (alloc_merge_fence)
[833.385178] Starting subtest: alloc_merge_fence
[833.386059] Subtest alloc_merge_fence: SUCCESS (0.000s)
[833.502468] [118/133] (196s left) kms_pm_backlight (fade)
[833.686900] Subtest fade: SKIP (0.000s)
[833.748043] [119/133] (196s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[833.935015] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[833.935923] Starting dynamic subtest: pipe-A-valid-mode
[836.426097] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.487s)
[836.427510] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SUCCESS (2.491s)
[836.743320] [120/133] (193s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[836.821216] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[836.925849] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.104s)
[837.116316] [121/133] (193s left) kms_psr (psr-cursor-mmap-cpu)
[837.296968] Subtest psr-cursor-mmap-cpu: SKIP (0.000s)
[837.368969] [122/133] (192s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[837.567987] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[838.272223] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.703s)
[838.526765] [123/133] (191s left) gem_exec_whisper (basic-queues-priority-all)
[838.617333] Starting subtest: basic-queues-priority-all
[860.584854] Subtest basic-queues-priority-all: SUCCESS (21.969s)
[860.870805] [124/133] (169s left) syncobj_timeline (etime-single-wait-all-submitted)
[860.951099] Starting subtest: etime-single-wait-all-submitted
[861.053623] Subtest etime-single-wait-all-submitted: SUCCESS (0.102s)
[861.231782] [125/133] (169s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[861.419940] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[861.421611] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[861.619254] [126/133] (168s left) kms_async_flips (async-flip-dpms)
[861.806159] Starting subtest: async-flip-dpms
[862.039284] Starting dynamic subtest: pipe-A-DP-3
[864.837296] Dynamic subtest pipe-A-DP-3: SUCCESS (2.799s)
[865.151036] Starting dynamic subtest: pipe-B-DP-3
[867.237778] Dynamic subtest pipe-B-DP-3: SUCCESS (2.101s)
[867.451299] Starting dynamic subtest: pipe-C-DP-3
[869.529340] Dynamic subtest pipe-C-DP-3: SUCCESS (2.092s)
[869.747502] Starting dynamic subtest: pipe-D-DP-3
[871.825363] Dynamic subtest pipe-D-DP-3: SUCCESS (2.092s)
[871.826150] Subtest async-flip-dpms: SUCCESS (10.022s)
[872.262216] [127/133] (158s left) gem_exec_reloc (basic-cpu-read-noreloc)
[872.358129] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[872.460793] [128/133] (158s left) syncobj_wait (invalid-reset-illegal-handle)
[872.538005] Starting subtest: invalid-reset-illegal-handle
[872.538936] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[872.724643] [129/133] (158s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[872.808184] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[872.910149] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.101s)
[873.092447] [130/133] (157s left) gem_tiled_swapping (non-threaded)
[873.169353] Subtest non-threaded: SKIP (0.000s)
[873.250176] [131/133] (157s left) gem_exec_fence (syncobj-timeline-chain-engines)
[873.953158] Starting subtest: syncobj-timeline-chain-engines
[874.128549] Subtest syncobj-timeline-chain-engines: SUCCESS (0.176s)
[874.473627] [132/133] (156s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[874.657983] Starting subtest: flip-vs-cursor-legacy
[884.177561] Subtest flip-vs-cursor-legacy: SUCCESS (9.521s)
[884.488790] [133/133] (146s left) syncobj_basic (illegal-fd-to-handle)
[884.565360] Starting subtest: illegal-fd-to-handle
[884.566207] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[884.752462] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_exec_suspend
results: parsing output: 2/ for test: gem_render_copy
results: parsing output: 3/ for test: kms_ccs
results: parsing output: 4/ for test: kms_flip
results: parsing output: 5/ for test: syncobj_timeline
results: parsing output: 6/ for test: kms_lease
results: parsing output: 7/ for test: gem_exec_fence
results: parsing output: 8/ for test: kms_chamelium_color
results: parsing output: 9/ for test: prime_mmap
results: parsing output: 10/ for test: i915_drm_fdinfo
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_invalid_mode
results: parsing output: 13/ for test: kms_plane_scaling
results: parsing output: 14/ for test: drm_read
results: parsing output: 15/ for test: gem_ccs
results: parsing output: 16/ for test: kms_ccs
results: parsing output: 17/ for test: gem_close
results: parsing output: 18/ for test: gem_busy
results: parsing output: 19/ for test: kms_vblank
results: parsing output: 20/ for test: perf_pmu
results: parsing output: 21/ for test: kms_debugfs
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: gem_ctx_param
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: gem_exec_big
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: gem_exec_flush
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: gem_exec_create
results: parsing output: 31/ for test: kms_feature_discovery
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gem_render_copy_redux
results: parsing output: 35/ for test: i915_pm_rpm
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_request_retire
results: parsing output: 38/ for test: i915_pm_rps
results: parsing output: 39/ for test: gem_ctx_persistence
results: parsing output: 40/ for test: i915_hangman
results: parsing output: 41/ for test: kms_cursor_crc
results: parsing output: 42/ for test: gem_partial_pwrite_pread
results: parsing output: 43/ for test: gem_mmap_wc
results: parsing output: 44/ for test: syncobj_timeline
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_psr
results: parsing output: 47/ for test: kms_invalid_mode
results: parsing output: 48/ for test: gem_exec_reloc
results: parsing output: 49/ for test: gem_mmap_gtt
results: parsing output: 50/ for test: kms_prop_blob
results: parsing output: 51/ for test: api_intel_allocator
results: parsing output: 52/ for test: kms_getfb
results: parsing output: 53/ for test: kms_content_protection
results: parsing output: 54/ for test: kms_chamelium_hpd
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: gem_mmap_offset
results: parsing output: 57/ for test: kms_psr
results: parsing output: 58/ for test: gem_fenced_exec_thrash
results: parsing output: 59/ for test: kms_vblank
results: parsing output: 60/ for test: gem_exec_whisper
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: kms_atomic
results: parsing output: 63/ for test: gen9_exec_parse
results: parsing output: 64/ for test: kms_cursor_crc
results: parsing output: 65/ for test: kms_cursor_crc
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: gem_ctx_shared
results: parsing output: 68/ for test: kms_plane_scaling
results: parsing output: 69/ for test: gem_wait
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: kms_cursor_legacy
results: parsing output: 72/ for test: gem_basic
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: kms_psr2_sf
results: parsing output: 75/ for test: drm_read
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_psr
results: parsing output: 78/ for test: kms_ccs
results: parsing output: 79/ for test: kms_ccs
results: parsing output: 80/ for test: sw_sync
results: parsing output: 81/ for test: sysfs_heartbeat_interval
results: parsing output: 82/ for test: syncobj_eventfd
results: parsing output: 83/ for test: kms_busy
results: parsing output: 84/ for test: kms_psr2_sf
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: gem_exec_balancer
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: vgem_slow
results: parsing output: 89/ for test: gem_spin_batch
results: parsing output: 90/ for test: gem_render_copy
results: parsing output: 91/ for test: syncobj_timeline
results: parsing output: 92/ for test: gem_exec_schedule
results: parsing output: 93/ for test: gem_pwrite_snooped
results: parsing output: 94/ for test: kms_tiled_display
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: gem_pwrite
results: parsing output: 98/ for test: kms_pm_rpm
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_color_pipeline
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: gem_exec_schedule
results: parsing output: 105/ for test: api_intel_bb
results: parsing output: 106/ for test: gem_mmap
results: parsing output: 107/ for test: kms_flip_scaled_crc
results: parsing output: 108/ for test: kms_addfb_basic
results: parsing output: 109/ for test: kms_psr
results: parsing output: 110/ for test: kms_draw_crc
results: parsing output: 111/ for test: perf_pmu
results: parsing output: 112/ for test: kms_ccs
results: parsing output: 113/ for test: gem_exec_flush
results: parsing output: 114/ for test: gem_mmap_wc
results: parsing output: 115/ for test: kms_plane_lowres
results: parsing output: 116/ for test: sw_sync
results: parsing output: 117/ for test: kms_pm_backlight
results: parsing output: 118/ for test: kms_flip_scaled_crc
results: parsing output: 119/ for test: syncobj_wait
results: parsing output: 120/ for test: kms_psr
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: gem_exec_whisper
results: parsing output: 123/ for test: syncobj_timeline
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_async_flips
results: parsing output: 126/ for test: gem_exec_reloc
results: parsing output: 127/ for test: syncobj_wait
results: parsing output: 128/ for test: syncobj_wait
results: parsing output: 129/ for test: gem_tiled_swapping
results: parsing output: 130/ for test: gem_exec_fence
results: parsing output: 131/ for test: kms_cursor_legacy
results: parsing output: 132/ for test: syncobj_basic
Done.