[61.566871] Initializing watchdogs
[61.566937]   /dev/watchdog0
[61.587087] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[61.598474] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[61.602490] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.604854] [001/132] (960s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[61.791178] Starting subtest: read-crc-frame-sequence
[61.791993] Starting dynamic subtest: pipe-A-DP-3
[62.455085] Dynamic subtest pipe-A-DP-3: SUCCESS (0.662s)
[62.470662] Starting dynamic subtest: pipe-B-DP-3
[63.028412] Dynamic subtest pipe-B-DP-3: SUCCESS (0.571s)
[63.037453] Starting dynamic subtest: pipe-C-DP-3
[63.586204] Dynamic subtest pipe-C-DP-3: SUCCESS (0.557s)
[63.599513] Starting dynamic subtest: pipe-D-DP-3
[64.136171] Dynamic subtest pipe-D-DP-3: SUCCESS (0.548s)
[64.137256] Subtest read-crc-frame-sequence: SUCCESS (2.344s)
[64.453233] [002/132] (957s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[64.635531] Starting subtest: psr-farfromfence-mmap-gtt
[64.637241] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[64.820085] [003/132] (957s left) gem_mmap_offset (bad-flags)
[64.888246] Starting subtest: bad-flags
[64.889162] Subtest bad-flags: SUCCESS (0.000s)
[65.085469] [004/132] (957s left) i915_drm_fdinfo (memory-info-idle)
[65.154043] Starting subtest: memory-info-idle
[65.154939] Starting dynamic subtest: lmem0
[65.271406] Dynamic subtest lmem0: SUCCESS (0.118s)
[65.288196] Starting dynamic subtest: smem0
[65.351053] Dynamic subtest smem0: SUCCESS (0.079s)
[65.352234] Subtest memory-info-idle: SUCCESS (0.198s)
[65.484210] [005/132] (956s left) kms_content_protection (lic-type-0-hdcp14)
[65.730067] Starting subtest: lic-type-0-hdcp14
[65.759104] Starting dynamic subtest: pipe-A-DP-3
[186.926930] Dynamic subtest pipe-A-DP-3: FAIL (120.975s)
[186.927799] Subtest lic-type-0-hdcp14: FAIL (121.092s)
[187.147313] [006/132] (835s left) kms_selftest (drm_dp_mst_helper)
[187.192247] Starting subtest: drm_dp_mst_helper
[187.200992] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[187.309443] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.108s)
[187.340387] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[187.417878] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.107s)
[187.435844] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[187.534070] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.115s)
[187.535712] Subtest drm_dp_mst_helper: SUCCESS (0.340s)
[187.764010] [007/132] (834s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[187.836103] Starting subtest: multi-wait-available-submitted-signaled
[187.837063] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.001s)
[188.034964] [008/132] (834s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[188.219415] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[188.221114] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[188.414843] [009/132] (834s left) gem_exec_params (cliprects-invalid)
[188.487653] Starting subtest: cliprects-invalid
[188.488560] Subtest cliprects-invalid: SUCCESS (0.000s)
[188.696257] [010/132] (834s left) gem_userptr_blits (unsync-unmap)
[188.780142] Subtest unsync-unmap: SKIP (0.000s)
[188.999492] [011/132] (833s left) gen9_exec_parse (basic-rejected-ctx-param)
[189.075577] Subtest basic-rejected-ctx-param: SKIP (0.000s)
[189.212901] [012/132] (833s left) gem_exec_balancer (sliced)
[189.296160] Starting subtest: sliced
[189.298646] Subtest sliced: SKIP (0.000s)
[189.729023] [013/132] (833s left) kms_atomic_transition (modeset-transition-fencing)
[189.907948] Starting subtest: modeset-transition-fencing
[189.908900] Starting dynamic subtest: 1x-outputs
[192.546378] Dynamic subtest 1x-outputs: SUCCESS (2.637s)
[192.548130] Subtest modeset-transition-fencing: SUCCESS (2.638s)
[192.803228] [014/132] (830s left) syncobj_timeline (host-signal-ordered)
[192.874138] Starting subtest: host-signal-ordered
[192.875138] Subtest host-signal-ordered: SUCCESS (0.001s)
[193.034012] [015/132] (830s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[193.233218] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[193.235205] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[193.418819] [016/132] (829s left) gem_fence_thrash (bo-write-verify-threaded-none)
[193.461441] Starting subtest: bo-write-verify-threaded-none
[193.490774] Subtest bo-write-verify-threaded-none: SKIP (0.029s)
[193.568484] [017/132] (829s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[193.746881] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[193.747750] Starting dynamic subtest: pipe-A-valid-mode
[194.727631] Dynamic subtest pipe-A-valid-mode: SKIP (0.980s)
[194.729965] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.981s)
[195.045266] [018/132] (828s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[195.225871] Starting subtest: flip-vs-cursor-crc-atomic
[195.796654] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.570s)
[196.129631] [019/132] (827s left) gem_create (create-ext-placement-sanity-check)
[196.312297] Starting subtest: create-ext-placement-sanity-check
[196.314408] Subtest create-ext-placement-sanity-check: SUCCESS (0.002s)
[196.475225] [020/132] (827s left) gem_exec_flush (basic-batch-kernel-default-wb)
[196.557328] Subtest basic-batch-kernel-default-wb: SKIP (0.000s)
[196.646663] [021/132] (826s left) perf (non-zero-reason)
[197.025682] Starting subtest: non-zero-reason
[197.026487] Starting dynamic subtest: 0-rcs0
[200.082714] Dynamic subtest 0-rcs0: FAIL (2.747s)
[200.084265] Subtest non-zero-reason: FAIL (2.747s)
[200.152613] [022/132] (823s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[200.326899] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[200.327767] Starting dynamic subtest: pipe-A-DP-3
[200.349061] Dynamic subtest pipe-A-DP-3: SKIP (0.002s)
[200.357592] Starting dynamic subtest: pipe-B-DP-3
[200.378899] Dynamic subtest pipe-B-DP-3: SKIP (0.002s)
[200.387617] Starting dynamic subtest: pipe-C-DP-3
[200.413697] Dynamic subtest pipe-C-DP-3: SKIP (0.002s)
[200.422414] Starting dynamic subtest: pipe-D-DP-3
[200.445952] Dynamic subtest pipe-D-DP-3: SKIP (0.002s)
[200.447436] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SKIP (0.011s)
[200.822788] [023/132] (822s left) kms_getfb (getfb-addfb-different-handles)
[200.999117] Starting subtest: getfb-addfb-different-handles
[200.999983] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[201.200629] [024/132] (822s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[201.383511] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[201.385186] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[201.588487] [025/132] (822s left) kms_plane_multiple (tiling-yf)
[201.766942] Starting subtest: tiling-yf
[201.768729] Subtest tiling-yf: SKIP (0.000s)
[201.921986] [026/132] (822s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[202.099212] Starting subtest: plane-downscale-factor-0-75-with-rotation
[202.100027] Starting dynamic subtest: pipe-A
[202.475341] Dynamic subtest pipe-A: SUCCESS (0.376s)
[202.489625] Starting dynamic subtest: pipe-B
[202.936489] Dynamic subtest pipe-B: SUCCESS (0.461s)
[202.952267] Starting dynamic subtest: pipe-C
[203.416548] Dynamic subtest pipe-C: SUCCESS (0.479s)
[203.440374] Starting dynamic subtest: pipe-D
[203.892822] Dynamic subtest pipe-D: SUCCESS (0.475s)
[203.894023] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (1.794s)
[204.267263] [027/132] (819s left) gem_exec_schedule (u-fairslice)
[204.356676] Starting subtest: u-fairslice
[204.357563] Starting dynamic subtest: rcs0
[206.411323] Dynamic subtest rcs0: SUCCESS (2.054s)
[206.420199] Starting dynamic subtest: bcs0
[208.432407] Dynamic subtest bcs0: SUCCESS (2.021s)
[208.441501] Starting dynamic subtest: vcs0
[210.452922] Dynamic subtest vcs0: SUCCESS (2.020s)
[210.461608] Starting dynamic subtest: vcs1
[212.473919] Dynamic subtest vcs1: SUCCESS (2.021s)
[212.482978] Starting dynamic subtest: vecs0
[214.492891] Dynamic subtest vecs0: SUCCESS (2.019s)
[214.501784] Starting dynamic subtest: vecs1
[216.512887] Dynamic subtest vecs1: SUCCESS (2.020s)
[216.522078] Starting dynamic subtest: ccs0
[218.532844] Dynamic subtest ccs0: SUCCESS (2.020s)
[218.533742] Subtest u-fairslice: SUCCESS (14.175s)
[218.951445] [028/132] (805s left) gem_exec_reloc (basic-wc-read)
[219.029315] Subtest basic-wc-read: SKIP (0.000s)
[219.113088] [029/132] (805s left) gem_softpin (reverse)
[219.189354] Starting subtest: reverse
[219.201006] Subtest reverse: SUCCESS (0.012s)
[219.399416] [030/132] (804s left) gem_exec_balancer (bonded-pair)
[219.479950] Starting subtest: bonded-pair
[219.482071] Subtest bonded-pair: SKIP (0.000s)
[219.895136] [031/132] (804s left) gem_exec_fence (invalid-fence-array)
[220.445067] Starting subtest: invalid-fence-array
[220.446946] Subtest invalid-fence-array: SUCCESS (0.002s)
[220.883841] [FACT gem_exec_fence (invalid-fence-array)] new: kernel.kmod_is_loaded.vgem: true
[220.885856] [032/132] (803s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[221.080081] Starting subtest: primary-y-tiled-reflect-x-90
[221.081898] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s)
[221.242346] [033/132] (803s left) kms_flip_tiling (flip-change-tiling)
[221.429528] Starting subtest: flip-change-tiling
[221.430396] Starting dynamic subtest: pipe-A-DP-3-4-to-4
[221.690169] Dynamic subtest pipe-A-DP-3-4-to-4: SUCCESS (0.258s)
[221.703508] Starting dynamic subtest: pipe-A-DP-3-4-to-x
[221.873388] Dynamic subtest pipe-A-DP-3-4-to-x: SUCCESS (0.182s)
[221.885874] Starting dynamic subtest: pipe-A-DP-3-4-to-linear
[222.056555] Dynamic subtest pipe-A-DP-3-4-to-linear: SUCCESS (0.182s)
[222.093592] Starting dynamic subtest: pipe-A-DP-3-x-to-4
[222.273296] Dynamic subtest pipe-A-DP-3-x-to-4: SUCCESS (0.215s)
[222.311146] Starting dynamic subtest: pipe-A-DP-3-x-to-x
[222.456652] Dynamic subtest pipe-A-DP-3-x-to-x: SUCCESS (0.182s)
[222.470301] Starting dynamic subtest: pipe-A-DP-3-x-to-linear
[222.640568] Dynamic subtest pipe-A-DP-3-x-to-linear: SUCCESS (0.182s)
[222.676894] Starting dynamic subtest: pipe-A-DP-3-linear-to-4
[222.856796] Dynamic subtest pipe-A-DP-3-linear-to-4: SUCCESS (0.215s)
[222.870509] Starting dynamic subtest: pipe-A-DP-3-linear-to-x
[223.042867] Dynamic subtest pipe-A-DP-3-linear-to-x: SUCCESS (0.182s)
[223.056447] Starting dynamic subtest: pipe-A-DP-3-linear-to-linear
[223.189833] Dynamic subtest pipe-A-DP-3-linear-to-linear: SUCCESS (0.148s)
[223.254366] Starting dynamic subtest: pipe-B-DP-3-4-to-4
[223.571187] Dynamic subtest pipe-B-DP-3-4-to-4: SUCCESS (0.330s)
[223.607081] Starting dynamic subtest: pipe-B-DP-3-4-to-x
[223.737067] Dynamic subtest pipe-B-DP-3-4-to-x: SUCCESS (0.165s)
[223.749378] Starting dynamic subtest: pipe-B-DP-3-4-to-linear
[223.870413] Dynamic subtest pipe-B-DP-3-4-to-linear: SUCCESS (0.133s)
[223.882577] Starting dynamic subtest: pipe-B-DP-3-x-to-4
[224.003550] Dynamic subtest pipe-B-DP-3-x-to-4: SUCCESS (0.132s)
[224.024363] Starting dynamic subtest: pipe-B-DP-3-x-to-x
[224.153666] Dynamic subtest pipe-B-DP-3-x-to-x: SUCCESS (0.149s)
[224.174837] Starting dynamic subtest: pipe-B-DP-3-x-to-linear
[224.303636] Dynamic subtest pipe-B-DP-3-x-to-linear: SUCCESS (0.149s)
[224.321935] Starting dynamic subtest: pipe-B-DP-3-linear-to-4
[224.453595] Dynamic subtest pipe-B-DP-3-linear-to-4: SUCCESS (0.149s)
[224.474987] Starting dynamic subtest: pipe-B-DP-3-linear-to-x
[224.603677] Dynamic subtest pipe-B-DP-3-linear-to-x: SUCCESS (0.149s)
[224.624352] Starting dynamic subtest: pipe-B-DP-3-linear-to-linear
[224.753633] Dynamic subtest pipe-B-DP-3-linear-to-linear: SUCCESS (0.149s)
[224.797253] Starting dynamic subtest: pipe-C-DP-3-4-to-4
[225.118199] Dynamic subtest pipe-C-DP-3-4-to-4: SUCCESS (0.329s)
[225.131357] Starting dynamic subtest: pipe-C-DP-3-4-to-x
[225.267851] Dynamic subtest pipe-C-DP-3-4-to-x: SUCCESS (0.148s)
[225.303716] Starting dynamic subtest: pipe-C-DP-3-4-to-linear
[225.434067] Dynamic subtest pipe-C-DP-3-4-to-linear: SUCCESS (0.165s)
[225.455584] Starting dynamic subtest: pipe-C-DP-3-x-to-4
[225.583891] Dynamic subtest pipe-C-DP-3-x-to-4: SUCCESS (0.149s)
[225.599834] Starting dynamic subtest: pipe-C-DP-3-x-to-x
[225.734195] Dynamic subtest pipe-C-DP-3-x-to-x: SUCCESS (0.149s)
[225.765963] Starting dynamic subtest: pipe-C-DP-3-x-to-linear
[225.900599] Dynamic subtest pipe-C-DP-3-x-to-linear: SUCCESS (0.166s)
[225.926301] Starting dynamic subtest: pipe-C-DP-3-linear-to-4
[226.067475] Dynamic subtest pipe-C-DP-3-linear-to-4: SUCCESS (0.166s)
[226.093350] Starting dynamic subtest: pipe-C-DP-3-linear-to-x
[226.234182] Dynamic subtest pipe-C-DP-3-linear-to-x: SUCCESS (0.166s)
[226.265926] Starting dynamic subtest: pipe-C-DP-3-linear-to-linear
[226.400635] Dynamic subtest pipe-C-DP-3-linear-to-linear: SUCCESS (0.166s)
[226.443456] Starting dynamic subtest: pipe-D-DP-3-4-to-4
[226.764231] Dynamic subtest pipe-D-DP-3-4-to-4: SUCCESS (0.328s)
[226.800213] Starting dynamic subtest: pipe-D-DP-3-4-to-x
[226.929946] Dynamic subtest pipe-D-DP-3-4-to-x: SUCCESS (0.165s)
[226.945909] Starting dynamic subtest: pipe-D-DP-3-4-to-linear
[227.080150] Dynamic subtest pipe-D-DP-3-4-to-linear: SUCCESS (0.149s)
[227.106450] Starting dynamic subtest: pipe-D-DP-3-x-to-4
[227.246860] Dynamic subtest pipe-D-DP-3-x-to-4: SUCCESS (0.166s)
[227.259502] Starting dynamic subtest: pipe-D-DP-3-x-to-x
[227.380052] Dynamic subtest pipe-D-DP-3-x-to-x: SUCCESS (0.132s)
[227.392152] Starting dynamic subtest: pipe-D-DP-3-x-to-linear
[227.513348] Dynamic subtest pipe-D-DP-3-x-to-linear: SUCCESS (0.133s)
[227.533984] Starting dynamic subtest: pipe-D-DP-3-linear-to-4
[227.663239] Dynamic subtest pipe-D-DP-3-linear-to-4: SUCCESS (0.149s)
[227.679237] Starting dynamic subtest: pipe-D-DP-3-linear-to-x
[227.813420] Dynamic subtest pipe-D-DP-3-linear-to-x: SUCCESS (0.149s)
[227.838780] Starting dynamic subtest: pipe-D-DP-3-linear-to-linear
[227.980215] Dynamic subtest pipe-D-DP-3-linear-to-linear: SUCCESS (0.166s)
[228.013157] Subtest flip-change-tiling: SUCCESS (6.583s)
[228.361030] [034/132] (796s left) kms_addfb_basic (basic-x-tiled-legacy)
[228.445025] Starting subtest: basic-x-tiled-legacy
[228.446814] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[228.760128] [035/132] (795s left) gem_userptr_blits (sync-unmap-after-close)
[228.853466] Starting subtest: sync-unmap-after-close
[228.872990] Subtest sync-unmap-after-close: SUCCESS (0.019s)
[229.111773] [036/132] (795s left) gem_exec_whisper (basic-fds-forked)
[229.198541] Starting subtest: basic-fds-forked
[252.088537] Subtest basic-fds-forked: SUCCESS (22.888s)
[252.368086] [037/132] (772s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[252.558428] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[252.618999] [038/132] (772s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[252.814586] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[252.816215] Subtest psr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[253.006124] [039/132] (771s left) kms_prime (basic-modeset-hybrid)
[253.195859] Subtest basic-modeset-hybrid: SKIP (0.000s)
[253.408672] [040/132] (771s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[253.492974] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[253.588654] [041/132] (771s left) kms_cursor_crc (cursor-random-512x170)
[254.061266] Starting subtest: cursor-random-512x170
[254.063015] Subtest cursor-random-512x170: SKIP (0.001s)
[254.323071] [042/132] (770s left) perf_pmu (multi-client)
[254.393169] Starting subtest: multi-client
[254.394103] Starting dynamic subtest: rcs0
[255.486357] Dynamic subtest rcs0: SUCCESS (1.092s)
[255.500715] Starting dynamic subtest: bcs0
[256.539062] Dynamic subtest bcs0: SUCCESS (1.050s)
[256.551257] Starting dynamic subtest: vcs0
[257.592321] Dynamic subtest vcs0: SUCCESS (1.051s)
[257.606693] Starting dynamic subtest: vcs1
[258.644447] Dynamic subtest vcs1: SUCCESS (1.050s)
[258.658660] Starting dynamic subtest: vecs0
[259.697544] Dynamic subtest vecs0: SUCCESS (1.051s)
[259.712370] Starting dynamic subtest: vecs1
[260.750573] Dynamic subtest vecs1: SUCCESS (1.051s)
[260.762214] Starting dynamic subtest: ccs0
[261.807350] Dynamic subtest ccs0: SUCCESS (1.055s)
[261.809114] Subtest multi-client: SUCCESS (7.414s)
[262.009253] [043/132] (763s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[262.203317] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[263.461528] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.258s)
[263.675269] [044/132] (761s left) gem_ctx_persistence (engines-mixed)
[263.773884] Starting subtest: engines-mixed
[263.774826] Starting dynamic subtest: rcs0
[263.876457] Dynamic subtest rcs0: SUCCESS (0.102s)
[263.888705] Starting dynamic subtest: bcs0
[263.939794] Dynamic subtest bcs0: SUCCESS (0.062s)
[263.979385] Starting dynamic subtest: vcs0
[264.027715] Dynamic subtest vcs0: SUCCESS (0.087s)
[264.058877] Starting dynamic subtest: vcs1
[264.115096] Dynamic subtest vcs1: SUCCESS (0.086s)
[264.153597] Starting dynamic subtest: vecs0
[264.189376] Dynamic subtest vecs0: SUCCESS (0.073s)
[264.201504] Starting dynamic subtest: vecs1
[264.244315] Dynamic subtest vecs1: SUCCESS (0.054s)
[264.262229] Starting dynamic subtest: ccs0
[264.316123] Dynamic subtest ccs0: SUCCESS (0.070s)
[264.317876] Subtest engines-mixed: SUCCESS (0.543s)
[264.539332] [045/132] (760s left) syncobj_wait (reset-during-wait-for-submit)
[264.616058] Starting subtest: reset-during-wait-for-submit
[264.718885] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[264.866619] [046/132] (760s left) fbdev (read)
[264.928030] Starting subtest: read
[267.958882] Subtest read: SUCCESS (3.031s)
[268.078416] [047/132] (757s left) kms_cursor_crc (cursor-offscreen-max-size)
[268.572712] Starting subtest: cursor-offscreen-max-size
[268.575281] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[268.836541] [048/132] (756s left) kms_cursor_edge_walk (256x256-top-bottom)
[269.028944] Starting subtest: 256x256-top-bottom
[269.030898] Starting dynamic subtest: pipe-A-DP-3
[272.485047] Dynamic subtest pipe-A-DP-3: SUCCESS (3.454s)
[272.502793] Starting dynamic subtest: pipe-D-DP-3
[275.815605] Dynamic subtest pipe-D-DP-3: SUCCESS (3.328s)
[275.816499] Subtest 256x256-top-bottom: SUCCESS (6.786s)
[276.136199] [049/132] (749s left) kms_rotation_crc (sprite-rotation-180)
[276.321452] Starting subtest: sprite-rotation-180
[286.367316] Subtest sprite-rotation-180: SUCCESS (10.045s)
[286.778629] [050/132] (738s left) kms_psr (psr2-sprite-render)
[286.966357] Subtest psr2-sprite-render: SKIP (0.000s)
[287.020658] [051/132] (738s left) api_intel_allocator (reopen)
[287.099138] Starting subtest: reopen
[287.128221] Subtest reopen: SUCCESS (0.029s)
[287.360505] [052/132] (738s left) syncobj_timeline (reset-unsignaled)
[287.434133] Starting subtest: reset-unsignaled
[287.435076] Subtest reset-unsignaled: SUCCESS (0.000s)
[287.625777] [053/132] (738s left) kms_dsc (dsc-fractional-bpp-with-bpc)
[287.814953] Starting subtest: dsc-fractional-bpp-with-bpc
[287.826384] Subtest dsc-fractional-bpp-with-bpc: SKIP (0.001s)
[287.980435] [054/132] (737s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[288.170101] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[288.170998] Starting dynamic subtest: pipe-A-DP-3
[288.174403] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[288.184600] Starting dynamic subtest: pipe-B-DP-3
[288.188131] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[288.198170] Starting dynamic subtest: pipe-C-DP-3
[288.201636] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[288.211551] Starting dynamic subtest: pipe-D-DP-3
[288.214991] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[288.216617] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SKIP (0.005s)
[288.634934] [055/132] (737s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[288.825771] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[288.827399] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[289.017400] [056/132] (737s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[289.096252] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[289.210695] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.108s)
[289.379723] [057/132] (736s left) gem_render_copy_redux (flink-interruptible)
[289.462450] Starting subtest: flink-interruptible
[292.626201] Subtest flink-interruptible: SUCCESS (3.163s)
[292.881861] [058/132] (733s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[293.070062] Starting subtest: flip-vs-cursor-atomic
[303.145082] Subtest flip-vs-cursor-atomic: SUCCESS (10.074s)
[303.428559] [059/132] (722s left) vgem_basic (mmap)
[303.483431] Starting subtest: mmap
[303.507033] Subtest mmap: SUCCESS (0.023s)
[303.621992] [060/132] (722s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[303.829694] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[303.893254] [061/132] (722s left) kms_chamelium_color (ctm-blue-to-red)
[304.086873] Subtest ctm-blue-to-red: SKIP (0.000s)
[304.166365] [062/132] (722s left) syncobj_eventfd (timeline-wait-signaled)
[304.245162] Starting subtest: timeline-wait-signaled
[304.246110] Subtest timeline-wait-signaled: SUCCESS (0.000s)
[304.456334] [063/132] (722s left) syncobj_wait (multi-wait-all-submitted-signaled)
[304.533499] Starting subtest: multi-wait-all-submitted-signaled
[304.637268] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.103s)
[304.770716] [064/132] (721s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[304.961760] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[304.963438] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[305.166332] [065/132] (721s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[305.358536] Starting subtest: extended-pageflip-modeset-hang-oldfb
[305.360405] Starting dynamic subtest: pipe-A
[313.175463] Dynamic subtest pipe-A: SUCCESS (7.814s)
[313.187802] Starting dynamic subtest: pipe-D
[320.998339] Dynamic subtest pipe-D: SUCCESS (7.820s)
[320.999287] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (15.640s)
[321.308815] [066/132] (705s left) dmabuf_sync_file (import-multiple-read-write)
[321.375198] Starting subtest: import-multiple-read-write
[321.378812] Subtest import-multiple-read-write: SUCCESS (0.004s)
[321.525454] [067/132] (705s left) kms_psr (fbc-psr-primary-render)
[321.711398] Subtest fbc-psr-primary-render: SKIP (0.000s)
[321.768418] [068/132] (705s left) gen3_render_linear_blits
[321.918854] [069/132] (705s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[322.106058] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[322.107865] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[322.310186] [070/132] (704s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[322.395373] Starting subtest: yf-tiled-ccs-to-x-tiled
[322.397364] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[322.674258] [071/132] (704s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[322.862469] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[322.864554] Starting dynamic subtest: pipe-A-valid-mode
[322.952663] Dynamic subtest pipe-A-valid-mode: SKIP (0.088s)
[322.954506] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.090s)
[323.208912] [072/132] (704s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[323.396667] Starting subtest: plane-upscale-20x20-with-pixel-format
[323.397489] Starting dynamic subtest: pipe-A
[325.008634] Dynamic subtest pipe-A: SUCCESS (1.611s)
[325.023342] Starting dynamic subtest: pipe-B
[326.703736] Dynamic subtest pipe-B: SUCCESS (1.694s)
[326.718246] Starting dynamic subtest: pipe-C
[327.000156] Dynamic subtest pipe-C: SUCCESS (0.295s)
[327.028690] Starting dynamic subtest: pipe-D
[327.311933] Dynamic subtest pipe-D: SUCCESS (0.310s)
[327.312993] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (3.916s)
[327.692789] [073/132] (699s left) kms_flip (2x-plain-flip-fb-recreate)
[327.884053] Starting subtest: 2x-plain-flip-fb-recreate
[327.899313] Subtest 2x-plain-flip-fb-recreate: SKIP (0.015s)
[328.103112] [074/132] (699s left) gem_lmem_swapping (parallel-random)
[330.822072] Starting subtest: parallel-random
[330.822932] Starting dynamic subtest: lmem0
[376.045926] Dynamic subtest lmem0: SUCCESS (45.223s)
[376.047064] Subtest parallel-random: SUCCESS (45.224s)
[377.137259] [FACT gem_lmem_swapping (parallel-random)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[377.138808] [FACT gem_lmem_swapping (parallel-random)] deleted: kernel.kmod_is_loaded.i915: true
[377.140738] [075/132] (650s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[378.707849] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[378.709412] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[378.942796] [FACT gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[378.945624] [FACT gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)] new: kernel.kmod_is_loaded.i915: true
[378.948880] [076/132] (648s left) gem_exec_gttfill (engines)
[379.041218] Starting subtest: engines
[379.042188] Starting dynamic subtest: rcs0
[405.006450] Dynamic subtest rcs0: SUCCESS (25.964s)
[405.017081] Starting dynamic subtest: bcs0
[431.027647] Dynamic subtest bcs0: SUCCESS (26.020s)
[431.038793] Starting dynamic subtest: vcs0
[456.995975] Dynamic subtest vcs0: SUCCESS (25.966s)
[457.007143] Starting dynamic subtest: vcs1
[482.977912] Dynamic subtest vcs1: SUCCESS (25.981s)
[482.989218] Starting dynamic subtest: vecs0
[508.952938] Dynamic subtest vecs0: SUCCESS (25.973s)
[508.963442] Starting dynamic subtest: vecs1
[534.919976] Dynamic subtest vecs1: SUCCESS (25.965s)
[534.931055] Starting dynamic subtest: ccs0
[560.934971] Dynamic subtest ccs0: SUCCESS (26.014s)
[560.935931] Subtest engines: SUCCESS (181.890s)
[561.228501] [077/132] (466s left) gem_ctx_shared (q-smoketest)
[561.355432] Starting subtest: Q-smoketest
[561.356361] Starting dynamic subtest: rcs0
[566.812436] Dynamic subtest rcs0: SUCCESS (5.451s)
[566.823751] Starting dynamic subtest: bcs0
[572.241862] Dynamic subtest bcs0: SUCCESS (5.428s)
[572.252512] Starting dynamic subtest: vcs0
[577.656805] Dynamic subtest vcs0: SUCCESS (5.415s)
[577.667883] Starting dynamic subtest: vcs1
[583.082507] Dynamic subtest vcs1: SUCCESS (5.424s)
[583.093243] Starting dynamic subtest: vecs0
[588.502807] Dynamic subtest vecs0: SUCCESS (5.418s)
[588.513785] Starting dynamic subtest: vecs1
[593.925240] Dynamic subtest vecs1: SUCCESS (5.420s)
[593.936260] Starting dynamic subtest: ccs0
[599.348374] Dynamic subtest ccs0: SUCCESS (5.421s)
[599.349396] Subtest Q-smoketest: SUCCESS (37.986s)
[599.634819] [078/132] (428s left) gem_wait (write-busy)
[599.726085] Starting subtest: write-busy
[599.727204] Starting dynamic subtest: all-engines
[600.338340] Dynamic subtest all-engines: SUCCESS (0.612s)
[600.351773] Starting dynamic subtest: rcs0
[600.889128] Dynamic subtest rcs0: SUCCESS (0.550s)
[600.900366] Starting dynamic subtest: bcs0
[601.434909] Dynamic subtest bcs0: SUCCESS (0.545s)
[601.445877] Starting dynamic subtest: vcs0
[601.978303] Dynamic subtest vcs0: SUCCESS (0.542s)
[601.989491] Starting dynamic subtest: vcs1
[602.520076] Dynamic subtest vcs1: SUCCESS (0.541s)
[602.531292] Starting dynamic subtest: vecs0
[603.062367] Dynamic subtest vecs0: SUCCESS (0.541s)
[603.073486] Starting dynamic subtest: vecs1
[603.604122] Dynamic subtest vecs1: SUCCESS (0.541s)
[603.615459] Starting dynamic subtest: ccs0
[604.146846] Dynamic subtest ccs0: SUCCESS (0.542s)
[604.147799] Subtest write-busy: SUCCESS (4.421s)
[604.476743] [079/132] (423s left) kms_joiner (basic-ultra-joiner)
[604.678777] Starting subtest: basic-ultra-joiner
[604.680384] Subtest basic-ultra-joiner: SKIP (0.000s)
[604.854482] [080/132] (423s left) gem_pwrite (basic-self)
[604.933177] Subtest basic-self: SKIP (0.000s)
[605.005708] [081/132] (422s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[605.202068] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[605.203835] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s)
[605.410448] [082/132] (422s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[605.608749] Starting subtest: x-tiled-8bpp-rotate-180
[607.230316] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.621s)
[607.510989] [083/132] (420s left) syncobj_basic (bad-flags-fd-to-handle)
[607.590256] Starting subtest: bad-flags-fd-to-handle
[607.591492] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[607.760068] [084/132] (420s left) kms_display_modes (extended-mode-basic)
[607.954963] Starting subtest: extended-mode-basic
[607.956864] Subtest extended-mode-basic: SKIP (0.000s)
[608.040158] [085/132] (420s left) gem_exec_schedule (pi-shared-iova)
[608.293168] Starting subtest: pi-shared-iova
[608.294518] Starting dynamic subtest: rcs0
[608.571215] Dynamic subtest rcs0: SUCCESS (0.277s)
[608.582477] Starting dynamic subtest: bcs0
[608.751760] Dynamic subtest bcs0: SUCCESS (0.180s)
[608.762888] Starting dynamic subtest: vcs0
[608.937664] Dynamic subtest vcs0: SUCCESS (0.185s)
[608.948779] Starting dynamic subtest: vcs1
[609.124208] Dynamic subtest vcs1: SUCCESS (0.185s)
[609.135463] Starting dynamic subtest: vecs0
[609.314504] Dynamic subtest vecs0: SUCCESS (0.189s)
[609.325666] Starting dynamic subtest: vecs1
[609.500896] Dynamic subtest vecs1: SUCCESS (0.185s)
[609.512132] Starting dynamic subtest: ccs0
[609.689496] Dynamic subtest ccs0: SUCCESS (0.188s)
[609.690501] Subtest pi-shared-iova: SUCCESS (1.397s)
[610.127952] [086/132] (418s left) vgem_basic (busy-fence)
[610.196318] Starting subtest: busy-fence
[610.197230] Subtest busy-fence: SUCCESS (0.000s)
[610.355532] [087/132] (417s left) sw_sync (sync_busy_fork)
[610.404195] Starting subtest: sync_busy_fork
[611.417808] Subtest sync_busy_fork: SUCCESS (1.013s)
[611.535705] [088/132] (416s left) gem_mmap_wc (close)
[611.614059] Subtest close: SKIP (0.000s)
[611.692303] [089/132] (416s left) kms_flip (2x-flip-vs-expired-vblank)
[611.886093] Starting subtest: 2x-flip-vs-expired-vblank
[611.901423] Subtest 2x-flip-vs-expired-vblank: SKIP (0.015s)
[612.063758] [090/132] (416s left) gem_render_copy_redux (normal)
[612.150367] Starting subtest: normal
[612.893377] Subtest normal: SUCCESS (0.744s)
[613.083753] [091/132] (415s left) api_intel_bb (offset-control)
[613.162477] Starting subtest: offset-control
[613.197068] Subtest offset-control: SUCCESS (0.034s)
[613.427929] [092/132] (415s left) gem_linear_blits (normal)
[613.609740] Starting subtest: normal
[620.888167] Subtest normal: SUCCESS (7.278s)
[621.267724] [093/132] (407s left) gem_ctx_persistence (processes)
[621.389776] Starting subtest: processes
[622.917193] Subtest processes: SUCCESS (1.527s)
[623.049740] [094/132] (405s left) kms_lease (lease-invalid-plane)
[623.239974] Starting subtest: lease-invalid-plane
[623.242391] Starting dynamic subtest: pipe-A-DP-3
[623.243266] Dynamic subtest pipe-A-DP-3: SUCCESS (0.000s)
[623.255158] Starting dynamic subtest: pipe-B-DP-3
[623.256277] Dynamic subtest pipe-B-DP-3: SUCCESS (0.000s)
[623.268081] Starting dynamic subtest: pipe-C-DP-3
[623.269169] Dynamic subtest pipe-C-DP-3: SUCCESS (0.000s)
[623.280834] Starting dynamic subtest: pipe-D-DP-3
[623.282035] Dynamic subtest pipe-D-DP-3: SUCCESS (0.000s)
[623.283145] Subtest lease-invalid-plane: SUCCESS (0.006s)
[623.412333] [095/132] (405s left) gem_media_vme
[623.576745] [096/132] (405s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[623.770161] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[627.865287] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.094s)
[628.129909] [097/132] (400s left) i915_getparams_basic (basic-subslice-total)
[628.211519] Starting subtest: basic-subslice-total
[628.213382] Subtest basic-subslice-total: SUCCESS (0.000s)
[628.397435] [098/132] (400s left) kms_addfb_basic (invalid-set-prop-any)
[628.479714] Starting subtest: invalid-set-prop-any
[628.480576] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[628.782417] [099/132] (400s left) kms_chamelium_frames (dp-crc-fast)
[629.059665] Subtest dp-crc-fast: SKIP (0.000s)
[629.213966] [100/132] (400s left) sysfs_heartbeat_interval (invalid)
[629.298185] Starting subtest: invalid
[629.300432] Starting dynamic subtest: vecs0
[629.301300] Dynamic subtest vecs0: SUCCESS (0.000s)
[629.313261] Starting dynamic subtest: ccs0
[629.314437] Dynamic subtest ccs0: SUCCESS (0.000s)
[629.325926] Starting dynamic subtest: vcs0
[629.327237] Dynamic subtest vcs0: SUCCESS (0.000s)
[629.338683] Starting dynamic subtest: bcs0
[629.339849] Dynamic subtest bcs0: SUCCESS (0.000s)
[629.351147] Starting dynamic subtest: vecs1
[629.352386] Dynamic subtest vecs1: SUCCESS (0.000s)
[629.363913] Starting dynamic subtest: rcs0
[629.365260] Dynamic subtest rcs0: SUCCESS (0.000s)
[629.376806] Starting dynamic subtest: vcs1
[629.377960] Dynamic subtest vcs1: SUCCESS (0.000s)
[629.379137] Subtest invalid: SUCCESS (0.010s)
[629.456016] [101/132] (399s left) kms_addfb_basic (invalid-get-prop-any)
[629.543514] Starting subtest: invalid-get-prop-any
[629.544384] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[629.833489] [102/132] (399s left) kms_vblank (ts-continuation-dpms-suspend)
[630.020924] Starting subtest: ts-continuation-dpms-suspend
[630.023351] Starting dynamic subtest: pipe-A-DP-3
[649.707634] Dynamic subtest pipe-A-DP-3: SUCCESS (4.424s)
[649.724177] Starting dynamic subtest: pipe-D-DP-3
[668.863830] Dynamic subtest pipe-D-DP-3: SUCCESS (3.916s)
[668.864721] Subtest ts-continuation-dpms-suspend: SUCCESS (8.346s)
[669.133282] [103/132] (360s left) gem_exec_reloc (basic-write-cpu-active)
[669.221242] Subtest basic-write-cpu-active: SKIP (0.000s)
[669.299316] [104/132] (360s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[669.559233] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[669.709454] [105/132] (359s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[669.896577] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[669.898919] Starting dynamic subtest: pipe-A-DP-3
[669.907335] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[669.920983] Starting dynamic subtest: pipe-B-DP-3
[669.929522] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[669.942895] Starting dynamic subtest: pipe-C-DP-3
[669.951488] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[669.965329] Starting dynamic subtest: pipe-D-DP-3
[669.977035] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[669.979120] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SKIP (0.007s)
[670.402415] [106/132] (359s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[670.604327] Starting subtest: yf-tiled-64bpp-rotate-270
[670.606062] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[670.799524] [107/132] (358s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[670.986407] Starting subtest: bad-rotation-90-yf-tiled-ccs
[670.988667] Starting dynamic subtest: pipe-A-DP-3
[670.996852] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[671.010219] Starting dynamic subtest: pipe-B-DP-3
[671.018678] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[671.031893] Starting dynamic subtest: pipe-C-DP-3
[671.040048] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[671.053498] Starting dynamic subtest: pipe-D-DP-3
[671.064451] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[671.066163] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.007s)
[671.485812] [108/132] (358s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[671.676911] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[671.678648] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[671.885716] [109/132] (358s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[672.082256] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[672.084065] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[672.271555] [110/132] (357s left) kms_psr (fbc-pr-primary-mmap-gtt)
[672.460644] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[672.519489] [111/132] (357s left) kms_big_fb (linear-16bpp-rotate-270)
[672.718066] Starting subtest: linear-16bpp-rotate-270
[672.772233] Subtest linear-16bpp-rotate-270: SKIP (0.054s)
[673.006113] [112/132] (357s left) kms_properties (crtc-properties-legacy)
[673.189275] Starting subtest: crtc-properties-legacy
[673.191806] Starting dynamic subtest: pipe-A-DP-3
[673.545109] Dynamic subtest pipe-A-DP-3: SUCCESS (0.354s)
[673.562783] Starting dynamic subtest: pipe-B-DP-3
[673.847999] Dynamic subtest pipe-B-DP-3: SUCCESS (0.300s)
[673.865893] Starting dynamic subtest: pipe-C-DP-3
[674.199277] Dynamic subtest pipe-C-DP-3: SUCCESS (0.349s)
[674.213274] Starting dynamic subtest: pipe-D-DP-3
[674.532623] Dynamic subtest pipe-D-DP-3: SUCCESS (0.332s)
[674.533531] Subtest crtc-properties-legacy: SUCCESS (1.343s)
[674.875705] [113/132] (355s left) i915_suspend (sysfs-reader)
[674.966922] Starting subtest: sysfs-reader
[695.825738] Subtest sysfs-reader: SUCCESS (5.790s)
[695.911347] [114/132] (334s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[696.103252] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[696.104926] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[696.271823] [115/132] (334s left) kms_psr (psr2-primary-render)
[696.467770] Subtest psr2-primary-render: SKIP (0.000s)
[696.554976] [116/132] (333s left) i915_pm_rps (fence-order)
[696.647507] Starting subtest: fence-order
[700.791680] Subtest fence-order: SUCCESS (4.145s)
[701.021917] [117/132] (329s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite)
[701.217577] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite
[701.219291] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[701.404095] [118/132] (329s left) kms_psr (fbc-psr2-sprite-plane-move)
[701.587745] Subtest fbc-psr2-sprite-plane-move: SKIP (0.000s)
[701.649316] [119/132] (329s left) kms_flip (2x-dpms-vs-vblank-race-interruptible)
[701.839600] Starting subtest: 2x-dpms-vs-vblank-race-interruptible
[701.855310] Subtest 2x-dpms-vs-vblank-race-interruptible: SKIP (0.015s)
[702.034672] [120/132] (328s left) kms_color (invalid-ctm-matrix-sizes)
[702.221872] Starting subtest: invalid-ctm-matrix-sizes
[702.222720] Starting dynamic subtest: pipe-A
[702.224843] Dynamic subtest pipe-A: SUCCESS (0.003s)
[702.239004] Starting dynamic subtest: pipe-B
[702.239881] Dynamic subtest pipe-B: SUCCESS (0.005s)
[702.254331] Starting dynamic subtest: pipe-C
[702.255605] Dynamic subtest pipe-C: SUCCESS (0.005s)
[702.269835] Starting dynamic subtest: pipe-D
[702.271096] Dynamic subtest pipe-D: SUCCESS (0.006s)
[702.272240] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.024s)
[702.390832] [121/132] (328s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[702.579385] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[702.581119] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[702.769605] [122/132] (328s left) gem_fence_thrash (bo-write-verify-y)
[702.817467] Starting subtest: bo-write-verify-y
[702.854630] Subtest bo-write-verify-y: SKIP (0.037s)
[702.946488] [123/132] (328s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[703.040900] Starting subtest: multi-wait-for-submit-unsubmitted
[703.146327] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.104s)
[703.302839] [124/132] (327s left) sw_sync (sync_expired_merge)
[703.351404] Starting subtest: sync_expired_merge
[704.425701] Subtest sync_expired_merge: SUCCESS (1.074s)
[704.540509] [125/132] (326s left) kms_vblank (wait-busy)
[704.726746] Starting subtest: wait-busy
[704.727651] Starting dynamic subtest: pipe-A-DP-3
[707.213509] Dynamic subtest pipe-A-DP-3: SUCCESS (2.485s)
[707.234810] Starting dynamic subtest: pipe-D-DP-3
[709.639988] Dynamic subtest pipe-D-DP-3: SUCCESS (2.420s)
[709.640908] Subtest wait-busy: SUCCESS (4.914s)
[709.925534] [126/132] (321s left) kms_pm_rpm (package-g7)
[711.628022] Starting subtest: package-g7
[711.631420] Subtest package-g7: SKIP (0.000s)
[712.103889] [127/132] (319s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[712.292733] Starting subtest: cursorA-vs-flipB-toggle
[712.294502] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s)
[712.457042] [128/132] (318s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[712.648350] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[712.650097] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[712.857690] [129/132] (318s left) gem_workarounds (basic-read-fd)
[712.953281] Starting subtest: basic-read-fd
[712.993349] Subtest basic-read-fd: SUCCESS (0.040s)
[713.259721] [130/132] (318s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[713.449658] Starting subtest: basic-busy-flip-before-cursor-atomic
[713.451432] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[713.627969] [131/132] (318s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[713.713824] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[713.714980] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[713.866933] [132/132] (317s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu)
[714.058609] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu
[714.060412] Subtest fbcpsr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[714.270123] Closing watchdogs
results: parsing output: 0/ for test: kms_pipe_crc_basic
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: gem_mmap_offset
results: parsing output: 3/ for test: i915_drm_fdinfo
results: parsing output: 4/ for test: kms_content_protection
results: parsing output: 5/ for test: kms_selftest
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: gem_exec_params
results: parsing output: 9/ for test: gem_userptr_blits
results: parsing output: 10/ for test: gen9_exec_parse
results: parsing output: 11/ for test: gem_exec_balancer
results: parsing output: 12/ for test: kms_atomic_transition
results: parsing output: 13/ for test: syncobj_timeline
results: parsing output: 14/ for test: kms_big_fb
results: parsing output: 15/ for test: gem_fence_thrash
results: parsing output: 16/ for test: kms_flip_scaled_crc
results: parsing output: 17/ for test: kms_cursor_legacy
results: parsing output: 18/ for test: gem_create
results: parsing output: 19/ for test: gem_exec_flush
results: parsing output: 20/ for test: perf
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: kms_getfb
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_plane_multiple
results: parsing output: 25/ for test: kms_plane_scaling
results: parsing output: 26/ for test: gem_exec_schedule
results: parsing output: 27/ for test: gem_exec_reloc
results: parsing output: 28/ for test: gem_softpin
results: parsing output: 29/ for test: gem_exec_balancer
results: parsing output: 30/ for test: gem_exec_fence
results: parsing output: 31/ for test: kms_rotation_crc
results: parsing output: 32/ for test: kms_flip_tiling
results: parsing output: 33/ for test: kms_addfb_basic
results: parsing output: 34/ for test: gem_userptr_blits
results: parsing output: 35/ for test: gem_exec_whisper
results: parsing output: 36/ for test: kms_psr2_sf
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_prime
results: parsing output: 39/ for test: gem_fenced_exec_thrash
results: parsing output: 40/ for test: kms_cursor_crc
results: parsing output: 41/ for test: perf_pmu
results: parsing output: 42/ for test: kms_big_fb
results: parsing output: 43/ for test: gem_ctx_persistence
results: parsing output: 44/ for test: syncobj_wait
results: parsing output: 45/ for test: fbdev
results: parsing output: 46/ for test: kms_cursor_crc
results: parsing output: 47/ for test: kms_cursor_edge_walk
results: parsing output: 48/ for test: kms_rotation_crc
results: parsing output: 49/ for test: kms_psr
results: parsing output: 50/ for test: api_intel_allocator
results: parsing output: 51/ for test: syncobj_timeline
results: parsing output: 52/ for test: kms_dsc
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: syncobj_timeline
results: parsing output: 56/ for test: gem_render_copy_redux
results: parsing output: 57/ for test: kms_cursor_legacy
results: parsing output: 58/ for test: vgem_basic
results: parsing output: 59/ for test: kms_psr2_sf
results: parsing output: 60/ for test: kms_chamelium_color
results: parsing output: 61/ for test: syncobj_eventfd
results: parsing output: 62/ for test: syncobj_wait
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_busy
results: parsing output: 65/ for test: dmabuf_sync_file
results: parsing output: 66/ for test: kms_psr
results: parsing output: 67/ for test: gen3_render_linear_blits
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: gem_render_copy
results: parsing output: 70/ for test: kms_flip_scaled_crc
results: parsing output: 71/ for test: kms_plane_scaling
results: parsing output: 72/ for test: kms_flip
results: parsing output: 73/ for test: gem_lmem_swapping
results: parsing output: 74/ for test: gem_render_copy
results: parsing output: 75/ for test: gem_exec_gttfill
results: parsing output: 76/ for test: gem_ctx_shared
results: parsing output: 77/ for test: gem_wait
results: parsing output: 78/ for test: kms_joiner
results: parsing output: 79/ for test: gem_pwrite
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_big_fb
results: parsing output: 82/ for test: syncobj_basic
results: parsing output: 83/ for test: kms_display_modes
results: parsing output: 84/ for test: gem_exec_schedule
results: parsing output: 85/ for test: vgem_basic
results: parsing output: 86/ for test: sw_sync
results: parsing output: 87/ for test: gem_mmap_wc
results: parsing output: 88/ for test: kms_flip
results: parsing output: 89/ for test: gem_render_copy_redux
results: parsing output: 90/ for test: api_intel_bb
results: parsing output: 91/ for test: gem_linear_blits
results: parsing output: 92/ for test: gem_ctx_persistence
results: parsing output: 93/ for test: kms_lease
results: parsing output: 94/ for test: gem_media_vme
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: i915_getparams_basic
results: parsing output: 97/ for test: kms_addfb_basic
results: parsing output: 98/ for test: kms_chamelium_frames
results: parsing output: 99/ for test: sysfs_heartbeat_interval
results: parsing output: 100/ for test: kms_addfb_basic
results: parsing output: 101/ for test: kms_vblank
results: parsing output: 102/ for test: gem_exec_reloc
results: parsing output: 103/ for test: kms_chamelium_hpd
results: parsing output: 104/ for test: kms_ccs
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: kms_ccs
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: kms_psr
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: kms_properties
results: parsing output: 112/ for test: i915_suspend
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_psr
results: parsing output: 115/ for test: i915_pm_rps
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_psr
results: parsing output: 118/ for test: kms_flip
results: parsing output: 119/ for test: kms_color
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: gem_fence_thrash
results: parsing output: 122/ for test: syncobj_wait
results: parsing output: 123/ for test: sw_sync
results: parsing output: 124/ for test: kms_vblank
results: parsing output: 125/ for test: kms_pm_rpm
results: parsing output: 126/ for test: kms_cursor_legacy
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: gem_workarounds
results: parsing output: 129/ for test: kms_cursor_legacy
results: parsing output: 130/ for test: syncobj_wait
results: parsing output: 131/ for test: kms_frontbuffer_tracking
Done.