[62.668505] Initializing watchdogs
[62.668568]   /dev/watchdog0
[62.687850] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[62.698100] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[62.701746] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.704641] [001/131] (960s left) kms_atomic (atomic-invalid-params)
[62.884399] Starting subtest: atomic-invalid-params
[62.886404] Starting dynamic subtest: pipe-A-DP-3
[63.497229] Dynamic subtest pipe-A-DP-3: SUCCESS (0.613s)
[63.498267] Subtest atomic-invalid-params: SUCCESS (0.614s)
[63.820492] [002/131] (959s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[64.000449] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[64.002103] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[64.183682] [003/131] (959s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[64.363063] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[64.364038] Starting dynamic subtest: pipe-A-DP-3
[64.367456] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[64.375171] Starting dynamic subtest: pipe-B-DP-3
[64.378781] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[64.386252] Starting dynamic subtest: pipe-C-DP-3
[64.389618] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[64.397103] Starting dynamic subtest: pipe-D-DP-3
[64.400407] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[64.402112] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.004s)
[64.845298] [004/131] (958s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[64.912898] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[65.020254] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.107s)
[65.157706] [005/131] (958s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[65.342369] Starting subtest: x-tiled-16bpp-rotate-180
[67.297062] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.959s)
[67.910310] [006/131] (955s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[68.158568] Starting subtest: yf-tiled-32bpp-rotate-270
[68.160268] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[68.349341] [007/131] (955s left) kms_feature_discovery (psr1)
[68.529913] Starting subtest: psr1
[68.531667] Subtest psr1: SKIP (0.000s)
[68.698635] [008/131] (954s left) gen9_exec_parse (bb-start-out)
[68.778688] Subtest bb-start-out: SKIP (0.000s)
[68.830829] [009/131] (954s left) sw_sync (sync_merge_same)
[68.872637] Starting subtest: sync_merge_same
[68.873459] Subtest sync_merge_same: SUCCESS (0.001s)
[68.991033] [010/131] (954s left) kms_lease (lease-invalid-plane)
[69.167520] Starting subtest: lease-invalid-plane
[69.168407] Starting dynamic subtest: pipe-A-DP-3
[69.169300] Dynamic subtest pipe-A-DP-3: SUCCESS (0.000s)
[69.177240] Starting dynamic subtest: pipe-B-DP-3
[69.178159] Dynamic subtest pipe-B-DP-3: SUCCESS (0.000s)
[69.186237] Starting dynamic subtest: pipe-C-DP-3
[69.187100] Dynamic subtest pipe-C-DP-3: SUCCESS (0.000s)
[69.194730] Starting dynamic subtest: pipe-D-DP-3
[69.195825] Dynamic subtest pipe-D-DP-3: SUCCESS (0.000s)
[69.196943] Subtest lease-invalid-plane: SUCCESS (0.003s)
[69.312308] [011/131] (954s left) gem_pwrite (basic-random)
[69.378783] Subtest basic-random: SKIP (0.000s)
[69.463662] [012/131] (954s left) kms_psr (psr-sprite-mmap-cpu)
[69.638591] Subtest psr-sprite-mmap-cpu: SKIP (0.000s)
[69.696987] [013/131] (954s left) i915_drm_fdinfo (busy)
[69.758587] Starting subtest: busy
[69.759482] Starting dynamic subtest: rcs0
[69.772277] Dynamic subtest rcs0: SKIP (0.013s)
[69.780074] Starting dynamic subtest: bcs0
[69.781868] Dynamic subtest bcs0: SKIP (0.007s)
[69.789851] Starting dynamic subtest: vcs0
[69.792079] Dynamic subtest vcs0: SKIP (0.000s)
[69.800074] Starting dynamic subtest: vcs1
[69.801970] Dynamic subtest vcs1: SKIP (0.000s)
[69.809566] Starting dynamic subtest: vecs0
[69.811610] Dynamic subtest vecs0: SKIP (0.000s)
[69.819632] Starting dynamic subtest: vecs1
[69.821882] Dynamic subtest vecs1: SKIP (0.000s)
[69.829753] Starting dynamic subtest: ccs0
[69.832018] Dynamic subtest ccs0: SKIP (0.000s)
[69.833956] Subtest busy: SKIP (0.022s)
[69.909326] [014/131] (954s left) gem_exec_whisper (basic-forked-all)
[69.993943] Starting subtest: basic-forked-all
[72.822155] Subtest basic-forked-all: SUCCESS (2.831s)
[73.103902] [015/131] (950s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[73.282570] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[73.284233] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[73.462567] [016/131] (950s left) kms_frontbuffer_tracking (psr-1p-rte)
[73.642505] Starting subtest: psr-1p-rte
[73.644213] Subtest psr-1p-rte: SKIP (0.000s)
[73.808773] [017/131] (950s left) kms_cursor_crc (cursor-random-max-size)
[74.300406] Starting subtest: cursor-random-max-size
[74.304723] Subtest cursor-random-max-size: SKIP (0.000s)
[74.545938] [018/131] (949s left) kms_getfb (getfb-handle-protection)
[74.736762] Starting subtest: getfb-handle-protection
[74.751439] Subtest getfb-handle-protection: SUCCESS (0.014s)
[74.949057] [019/131] (949s left) syncobj_timeline (wait-for-submit-delayed-submit)
[75.025211] Starting subtest: wait-for-submit-delayed-submit
[75.128844] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[75.255340] [020/131] (949s left) kms_vblank (query-forked-busy-hang)
[75.426512] Starting subtest: query-forked-busy-hang
[75.428300] Starting dynamic subtest: pipe-A-DP-3
[101.567145] Dynamic subtest pipe-A-DP-3: SUCCESS (26.137s)
[101.577167] Starting dynamic subtest: pipe-D-DP-3
[126.570958] Dynamic subtest pipe-D-DP-3: SUCCESS (25.000s)
[126.572090] Subtest query-forked-busy-hang: SUCCESS (51.142s)
[126.841892] [021/131] (897s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[127.024530] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[127.026218] Subtest fbcpsr-rgb565-draw-mmap-wc: SKIP (0.000s)
[127.222373] [022/131] (897s left) gem_ctx_shared (q-promotion)
[127.305969] Starting subtest: Q-promotion
[127.306900] Starting dynamic subtest: rcs0
[127.614532] Dynamic subtest rcs0: SUCCESS (0.308s)
[127.624043] Starting dynamic subtest: bcs0
[127.799939] Dynamic subtest bcs0: SUCCESS (0.185s)
[127.808919] Starting dynamic subtest: vcs0
[127.989162] Dynamic subtest vcs0: SUCCESS (0.189s)
[127.998176] Starting dynamic subtest: vcs1
[128.181135] Dynamic subtest vcs1: SUCCESS (0.192s)
[128.190189] Starting dynamic subtest: vecs0
[128.370999] Dynamic subtest vecs0: SUCCESS (0.189s)
[128.380220] Starting dynamic subtest: vecs1
[128.565294] Dynamic subtest vecs1: SUCCESS (0.193s)
[128.574382] Starting dynamic subtest: ccs0
[128.758204] Dynamic subtest ccs0: SUCCESS (0.193s)
[128.759175] Subtest Q-promotion: SUCCESS (1.452s)
[129.182560] [FACT gem_ctx_shared (q-promotion)] new: kernel.kmod_is_loaded.vgem: true
[129.184610] [023/131] (895s left) kms_flip (plain-flip-ts-check)
[129.368237] Starting subtest: plain-flip-ts-check
[129.372025] Starting dynamic subtest: A-DP3
[137.506842] Dynamic subtest A-DP3: SUCCESS (8.134s)
[137.522176] Starting dynamic subtest: B-DP3
[145.556761] Dynamic subtest B-DP3: SUCCESS (8.048s)
[145.566321] Starting dynamic subtest: C-DP3
[153.608816] Dynamic subtest C-DP3: SUCCESS (8.051s)
[153.618690] Starting dynamic subtest: D-DP3
[161.662104] Dynamic subtest D-DP3: SUCCESS (8.052s)
[161.666854] Subtest plain-flip-ts-check: SUCCESS (32.299s)
[162.019533] [024/131] (862s left) gem_ctx_persistence (engines-cleanup)
[162.107275] Starting subtest: engines-cleanup
[162.108189] Starting dynamic subtest: rcs0
[162.235347] Dynamic subtest rcs0: SUCCESS (0.128s)
[162.245257] Starting dynamic subtest: bcs0
[162.285612] Dynamic subtest bcs0: SUCCESS (0.050s)
[162.297536] Starting dynamic subtest: vcs0
[162.334408] Dynamic subtest vcs0: SUCCESS (0.048s)
[162.349616] Starting dynamic subtest: vcs1
[162.357305] Dynamic subtest vcs1: SUCCESS (0.023s)
[162.372693] Starting dynamic subtest: vecs0
[162.424053] Dynamic subtest vecs0: SUCCESS (0.066s)
[162.459569] Starting dynamic subtest: vecs1
[162.489513] Dynamic subtest vecs1: SUCCESS (0.065s)
[162.509340] Starting dynamic subtest: ccs0
[162.546121] Dynamic subtest ccs0: SUCCESS (0.056s)
[162.547920] Subtest engines-cleanup: SUCCESS (0.439s)
[162.767459] [025/131] (862s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[162.955286] Starting subtest: psr-shrfb-scaledprimary
[162.956923] Subtest psr-shrfb-scaledprimary: SKIP (0.000s)
[163.154091] [026/131] (861s left) syncobj_timeline (signal)
[163.238834] Starting subtest: signal
[163.239691] Subtest signal: SUCCESS (0.000s)
[163.432851] [027/131] (861s left) kms_plane_scaling (invalid-num-scalers)
[163.623925] Starting subtest: invalid-num-scalers
[163.630579] Starting dynamic subtest: pipe-A-DP-3-invalid-num-scalers
[163.649585] Dynamic subtest pipe-A-DP-3-invalid-num-scalers: SUCCESS (0.019s)
[163.663900] Starting dynamic subtest: pipe-B-DP-3-invalid-num-scalers
[163.688988] Dynamic subtest pipe-B-DP-3-invalid-num-scalers: SUCCESS (0.032s)
[163.702961] Starting dynamic subtest: pipe-C-DP-3-invalid-num-scalers
[163.728039] Dynamic subtest pipe-C-DP-3-invalid-num-scalers: SUCCESS (0.032s)
[163.742749] Starting dynamic subtest: pipe-D-DP-3-invalid-num-scalers
[163.768009] Dynamic subtest pipe-D-DP-3-invalid-num-scalers: SUCCESS (0.032s)
[163.768726] Subtest invalid-num-scalers: SUCCESS (0.144s)
[163.902742] [028/131] (861s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[163.979894] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[164.084472] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.104s)
[164.266518] [029/131] (860s left) gen3_render_linear_blits
[164.416861] [030/131] (860s left) gem_exec_schedule (in-order)
[164.507453] Starting subtest: in-order
[164.508363] Starting dynamic subtest: rcs0
[164.793151] Dynamic subtest rcs0: SUCCESS (0.285s)
[164.801796] Starting dynamic subtest: bcs0
[164.998243] Dynamic subtest bcs0: SUCCESS (0.205s)
[165.006987] Starting dynamic subtest: vcs0
[165.206842] Dynamic subtest vcs0: SUCCESS (0.208s)
[165.215692] Starting dynamic subtest: vcs1
[165.419479] Dynamic subtest vcs1: SUCCESS (0.212s)
[165.428366] Starting dynamic subtest: vecs0
[165.629902] Dynamic subtest vecs0: SUCCESS (0.210s)
[165.638688] Starting dynamic subtest: vecs1
[165.840206] Dynamic subtest vecs1: SUCCESS (0.210s)
[165.849555] Starting dynamic subtest: ccs0
[166.071844] Dynamic subtest ccs0: SUCCESS (0.231s)
[166.072824] Subtest in-order: SUCCESS (1.564s)
[166.604735] [031/131] (858s left) kms_big_fb (linear-16bpp-rotate-180)
[166.803364] Starting subtest: linear-16bpp-rotate-180
[168.806906] Subtest linear-16bpp-rotate-180: SUCCESS (2.003s)
[169.053663] [032/131] (856s left) i915_suspend (basic-s3-without-i915)
[169.099930] Starting subtest: basic-s3-without-i915
[190.951922] Subtest basic-s3-without-i915: SUCCESS (5.773s)
[191.101277] [033/131] (834s left) gem_tiled_pread_pwrite
[191.306279] [034/131] (834s left) gem_exec_params (cliprects-invalid)
[191.398808] Starting subtest: cliprects-invalid
[191.399683] Subtest cliprects-invalid: SUCCESS (0.000s)
[191.539823] [035/131] (834s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[191.617491] Starting subtest: single-wait-for-submit-unsubmitted
[191.729407] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.107s)
[191.865258] [036/131] (833s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[192.063524] Starting subtest: y-tiled-16bpp-rotate-90
[192.065324] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[192.251530] [037/131] (833s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[192.444474] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[192.446107] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[192.652389] [038/131] (833s left) gem_spin_batch (legacy-resubmit)
[192.743758] Starting subtest: legacy-resubmit
[192.745551] Starting dynamic subtest: default
[192.784044] Dynamic subtest default: SUCCESS (0.039s)
[192.794917] Starting dynamic subtest: render
[192.795860] Dynamic subtest render: SUCCESS (0.002s)
[192.806263] Starting dynamic subtest: bsd
[192.807314] Dynamic subtest bsd: SUCCESS (0.002s)
[192.817448] Starting dynamic subtest: bsd1
[192.818727] Dynamic subtest bsd1: SUCCESS (0.001s)
[192.828504] Starting dynamic subtest: bsd2
[192.829381] Dynamic subtest bsd2: SUCCESS (0.002s)
[192.839084] Starting dynamic subtest: blt
[192.840193] Dynamic subtest blt: SUCCESS (0.002s)
[192.849973] Starting dynamic subtest: vebox
[192.851139] Dynamic subtest vebox: SUCCESS (0.002s)
[192.852219] Subtest legacy-resubmit: SUCCESS (0.055s)
[193.069337] [039/131] (832s left) perf_pmu (busy-start)
[193.137900] Starting subtest: busy-start
[193.138863] Starting dynamic subtest: rcs0
[195.720698] Dynamic subtest rcs0: SUCCESS (2.582s)
[195.735572] Starting dynamic subtest: bcs0
[198.268474] Dynamic subtest bcs0: SUCCESS (2.546s)
[198.283489] Starting dynamic subtest: vcs0
[200.817482] Dynamic subtest vcs0: SUCCESS (2.548s)
[200.832931] Starting dynamic subtest: vcs1
[203.366015] Dynamic subtest vcs1: SUCCESS (2.547s)
[203.381486] Starting dynamic subtest: vecs0
[205.915194] Dynamic subtest vecs0: SUCCESS (2.548s)
[205.930953] Starting dynamic subtest: vecs1
[208.462536] Dynamic subtest vecs1: SUCCESS (2.546s)
[208.478385] Starting dynamic subtest: ccs0
[211.011418] Dynamic subtest ccs0: SUCCESS (2.548s)
[211.013214] Subtest busy-start: SUCCESS (17.873s)
[211.185834] [040/131] (814s left) perf (invalid-oa-metric-set-id)
[211.570383] Starting subtest: invalid-oa-metric-set-id
[211.589236] Subtest invalid-oa-metric-set-id: SUCCESS (0.019s)
[211.652452] [041/131] (814s left) gem_exec_schedule (thriceslice)
[211.739074] Starting subtest: thriceslice
[211.740043] Starting dynamic subtest: rcs0
[211.790792] Dynamic subtest rcs0: SUCCESS (0.052s)
[211.807187] Starting dynamic subtest: bcs0
[211.827359] Dynamic subtest bcs0: SUCCESS (0.036s)
[211.854908] Starting dynamic subtest: vcs0
[211.870025] Dynamic subtest vcs0: SUCCESS (0.042s)
[211.891103] Starting dynamic subtest: vcs1
[211.931051] Dynamic subtest vcs1: SUCCESS (0.060s)
[211.958659] Starting dynamic subtest: vecs0
[211.977052] Dynamic subtest vecs0: SUCCESS (0.045s)
[212.002745] Starting dynamic subtest: vecs1
[212.019702] Dynamic subtest vecs1: SUCCESS (0.042s)
[212.038205] Starting dynamic subtest: ccs0
[212.056948] Dynamic subtest ccs0: SUCCESS (0.037s)
[212.058164] Subtest thriceslice: SUCCESS (0.319s)
[212.453540] [042/131] (813s left) gem_lmem_swapping (heavy-verify-random)
[215.089506] Starting subtest: heavy-verify-random
[215.091263] Starting dynamic subtest: lmem0
[231.166533] Dynamic subtest lmem0: SUCCESS (16.079s)
[231.167337] Subtest heavy-verify-random: SUCCESS (16.080s)
[232.436156] [FACT gem_lmem_swapping (heavy-verify-random)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[232.437080] [FACT gem_lmem_swapping (heavy-verify-random)] deleted: kernel.kmod_is_loaded.i915: true
[232.438569] [043/131] (793s left) syncobj_wait (wait-all-snapshot)
[233.988769] Starting subtest: wait-all-snapshot
[234.069876] Subtest wait-all-snapshot: SUCCESS (0.082s)
[234.151464] [FACT syncobj_wait (wait-all-snapshot)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[234.154424] [FACT syncobj_wait (wait-all-snapshot)] new: kernel.kmod_is_loaded.i915: true
[234.156997] [044/131] (791s left) syncobj_timeline (wait-zero-handles)
[234.252944] Starting subtest: wait-zero-handles
[234.254683] Subtest wait-zero-handles: SUCCESS (0.000s)
[234.446559] [045/131] (791s left) kms_vblank (query-idle-hang)
[234.629656] Starting subtest: query-idle-hang
[234.631631] Starting dynamic subtest: pipe-A-DP-3
[261.660964] Dynamic subtest pipe-A-DP-3: SUCCESS (27.029s)
[261.674541] Starting dynamic subtest: pipe-D-DP-3
[286.650618] Dynamic subtest pipe-D-DP-3: SUCCESS (24.987s)
[286.651521] Subtest query-idle-hang: SUCCESS (52.020s)
[286.982722] [046/131] (739s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[287.166247] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[287.168025] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[287.336349] [047/131] (738s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[287.524811] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[290.117374] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (2.593s)
[290.389886] [048/131] (736s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[290.641953] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[290.787791] [049/131] (735s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[290.983863] Starting subtest: 4-tiled-64bpp-rotate-180
[292.897306] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.913s)
[293.162839] [050/131] (733s left) kms_fence_pin_leak
[293.465080] [051/131] (733s left) gem_tiling_max_stride
[293.635737] [052/131] (733s left) kms_invalid_mode (int-max-clock)
[293.820140] Starting subtest: int-max-clock
[293.821025] Starting dynamic subtest: pipe-A-DP-3
[293.904925] Dynamic subtest pipe-A-DP-3: SUCCESS (0.084s)
[293.920167] Starting dynamic subtest: pipe-B-DP-3
[293.921405] Dynamic subtest pipe-B-DP-3: SUCCESS (0.001s)
[293.936568] Starting dynamic subtest: pipe-C-DP-3
[293.937796] Dynamic subtest pipe-C-DP-3: SUCCESS (0.001s)
[293.952648] Starting dynamic subtest: pipe-D-DP-3
[293.953607] Dynamic subtest pipe-D-DP-3: SUCCESS (0.001s)
[293.954544] Subtest int-max-clock: SUCCESS (0.092s)
[294.194887] [053/131] (732s left) i915_drm_fdinfo (virtual-idle)
[294.289582] Starting subtest: virtual-idle
[297.885898] Subtest virtual-idle: SUCCESS (3.595s)
[298.018789] [054/131] (728s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[298.094276] Starting subtest: multi-wait-all-for-submit-signaled
[298.095206] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[298.303389] [055/131] (728s left) gem_mmap_gtt (basic-small-copy)
[298.384061] Subtest basic-small-copy: SKIP (0.000s)
[298.456300] [056/131] (728s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[298.645323] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[298.661029] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.015s)
[298.848305] [057/131] (728s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[299.040543] Subtest psr2-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[299.089754] [058/131] (728s left) kms_psr (psr2-sprite-plane-onoff)
[299.271666] Subtest psr2-sprite-plane-onoff: SKIP (0.000s)
[299.340018] [059/131] (727s left) kms_flip (2x-wf_vblank-ts-check)
[299.527101] Starting subtest: 2x-wf_vblank-ts-check
[299.542374] Subtest 2x-wf_vblank-ts-check: SKIP (0.015s)
[299.730029] [060/131] (727s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[299.923006] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[299.973383] [061/131] (727s left) kms_chamelium_color (ctm-max)
[300.160215] Subtest ctm-max: SKIP (0.000s)
[300.223746] [062/131] (727s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[300.424464] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[300.426154] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[300.631550] [063/131] (726s left) kms_content_protection (legacy)
[300.883457] Starting subtest: legacy
[301.167637] Starting dynamic subtest: pipe-A-DP-3
[422.450771] Dynamic subtest pipe-A-DP-3: FAIL (121.023s)
[422.451768] Subtest legacy: FAIL (121.410s)
[422.615230] [064/131] (604s left) kms_psr (fbc-psr2-primary-render)
[422.799506] Subtest fbc-psr2-primary-render: SKIP (0.000s)
[422.858662] [065/131] (604s left) kms_properties (colorop-properties-atomic)
[423.041968] Starting subtest: colorop-properties-atomic
[423.042925] Starting dynamic subtest: pipe-A-DP-3
[423.191012] Dynamic subtest pipe-A-DP-3: SUCCESS (0.147s)
[423.211700] Starting dynamic subtest: pipe-B-DP-3
[423.366610] Dynamic subtest pipe-B-DP-3: SUCCESS (0.174s)
[423.383144] Starting dynamic subtest: pipe-C-DP-3
[423.537669] Dynamic subtest pipe-C-DP-3: SUCCESS (0.169s)
[423.552038] Starting dynamic subtest: pipe-D-DP-3
[423.725060] Dynamic subtest pipe-D-DP-3: SUCCESS (0.186s)
[423.725956] Subtest colorop-properties-atomic: SUCCESS (0.683s)
[424.042835] [066/131] (603s left) gem_ringfill (engines-basic)
[424.477626] Starting subtest: engines-basic
[424.479394] Starting dynamic subtest: rcs0
[424.570681] Dynamic subtest rcs0: SUCCESS (0.095s)
[424.589696] Starting dynamic subtest: bcs0
[424.614791] Dynamic subtest bcs0: SUCCESS (0.043s)
[424.643615] Starting dynamic subtest: vcs0
[424.660547] Dynamic subtest vcs0: SUCCESS (0.044s)
[424.685237] Starting dynamic subtest: vcs1
[424.704674] Dynamic subtest vcs1: SUCCESS (0.043s)
[424.721798] Starting dynamic subtest: vecs0
[424.746746] Dynamic subtest vecs0: SUCCESS (0.041s)
[424.763827] Starting dynamic subtest: vecs1
[424.788546] Dynamic subtest vecs1: SUCCESS (0.041s)
[424.807619] Starting dynamic subtest: ccs0
[424.830471] Dynamic subtest ccs0: SUCCESS (0.041s)
[424.831542] Subtest engines-basic: SUCCESS (0.357s)
[425.024954] [067/131] (602s left) gem_watchdog (default-virtual)
[425.111724] Starting subtest: default-virtual
[432.438364] Subtest default-virtual: SUCCESS (7.326s)
[432.535803] [068/131] (595s left) kms_dp_aux_dev
[433.208508] [069/131] (594s left) kms_chamelium_edid (hdmi-edid-read)
[433.466558] Subtest hdmi-edid-read: SKIP (0.000s)
[433.614294] [070/131] (594s left) kms_fbcon_fbt (psr)
[433.696866] Starting subtest: psr
[433.698607] Subtest psr: SKIP (0.000s)
[433.875071] [071/131] (594s left) syncobj_timeline (invalid-transfer-illegal-handle)
[433.960338] Starting subtest: invalid-transfer-illegal-handle
[433.961267] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[434.118882] [072/131] (593s left) gem_exec_reloc (basic-write-cpu-noreloc)
[434.199521] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[434.287914] [073/131] (593s left) gem_workarounds (suspend-resume)
[434.383273] Starting subtest: suspend-resume
[453.950238] Subtest suspend-resume: SUCCESS (3.757s)
[454.086148] [074/131] (574s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[454.278692] Starting subtest: fbcpsr-tiling-4
[454.280382] Subtest fbcpsr-tiling-4: SKIP (0.000s)
[454.473485] [075/131] (573s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[454.661357] Starting subtest: 2x-flip-vs-cursor-legacy
[454.663108] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.002s)
[454.836863] [076/131] (573s left) gem_ctx_persistence (idempotent)
[454.923539] Starting subtest: idempotent
[454.924470] Subtest idempotent: SUCCESS (0.000s)
[455.126998] [077/131] (573s left) kms_psr (psr2-cursor-blt)
[455.314360] Subtest psr2-cursor-blt: SKIP (0.000s)
[455.383102] [078/131] (573s left) kms_cursor_crc (cursor-offscreen-max-size)
[455.903243] Starting subtest: cursor-offscreen-max-size
[455.905945] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[456.136330] [079/131] (572s left) kms_force_connector_basic (prune-stale-modes)
[456.245448] Starting subtest: prune-stale-modes
[456.268096] Subtest prune-stale-modes: SUCCESS (0.023s)
[456.635307] [080/131] (571s left) kms_cursor_crc (cursor-suspend)
[456.894354] Starting subtest: cursor-suspend
[456.896510] Starting dynamic subtest: pipe-A-DP-3
[496.691795] Dynamic subtest pipe-A-DP-3: SUCCESS (8.171s)
[496.713149] Starting dynamic subtest: pipe-D-DP-3
[536.540229] Dynamic subtest pipe-D-DP-3: SUCCESS (7.874s)
[536.541231] Subtest cursor-suspend: SUCCESS (16.050s)
[537.098409] [081/131] (491s left) kms_plane_cursor (primary)
[537.282704] Starting subtest: primary
[537.285966] Starting dynamic subtest: pipe-A-DP-3-size-64
[540.282251] Dynamic subtest pipe-A-DP-3-size-64: SUCCESS (2.997s)
[540.344363] Starting dynamic subtest: pipe-A-DP-3-size-128
[543.449068] Dynamic subtest pipe-A-DP-3-size-128: SUCCESS (3.117s)
[543.516199] Starting dynamic subtest: pipe-A-DP-3-size-256
[546.599109] Dynamic subtest pipe-A-DP-3-size-256: SUCCESS (3.098s)
[546.726238] Starting dynamic subtest: pipe-B-DP-3-size-64
[549.912758] Dynamic subtest pipe-B-DP-3-size-64: SUCCESS (3.203s)
[549.959430] Starting dynamic subtest: pipe-B-DP-3-size-128
[553.079401] Dynamic subtest pipe-B-DP-3-size-128: SUCCESS (3.133s)
[553.129038] Starting dynamic subtest: pipe-B-DP-3-size-256
[556.229510] Dynamic subtest pipe-B-DP-3-size-256: SUCCESS (3.115s)
[556.338391] Starting dynamic subtest: pipe-C-DP-3-size-64
[559.490333] Dynamic subtest pipe-C-DP-3-size-64: SUCCESS (3.167s)
[559.535509] Starting dynamic subtest: pipe-C-DP-3-size-128
[562.623691] Dynamic subtest pipe-C-DP-3-size-128: SUCCESS (3.100s)
[562.668905] Starting dynamic subtest: pipe-C-DP-3-size-256
[565.656404] Dynamic subtest pipe-C-DP-3-size-256: SUCCESS (3.000s)
[565.774689] Starting dynamic subtest: pipe-D-DP-3-size-64
[568.899414] Dynamic subtest pipe-D-DP-3-size-64: SUCCESS (3.144s)
[568.944674] Starting dynamic subtest: pipe-D-DP-3-size-128
[572.033378] Dynamic subtest pipe-D-DP-3-size-128: SUCCESS (3.100s)
[572.099401] Starting dynamic subtest: pipe-D-DP-3-size-256
[575.167310] Dynamic subtest pipe-D-DP-3-size-256: SUCCESS (3.098s)
[575.260625] Subtest primary: SUCCESS (37.975s)
[575.616590] [082/131] (453s left) gem_exec_balancer (fairslice)
[575.718015] Starting subtest: fairslice
[581.253587] Subtest fairslice: SUCCESS (5.534s)
[581.699932] [083/131] (447s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[581.886367] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[581.887315] Starting dynamic subtest: pipe-A-DP-3
[581.895641] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[581.908708] Starting dynamic subtest: pipe-B-DP-3
[581.917182] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[581.930034] Starting dynamic subtest: pipe-C-DP-3
[581.938245] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[581.951373] Starting dynamic subtest: pipe-D-DP-3
[581.961816] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[581.963633] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[582.375737] [084/131] (446s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[582.563755] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[582.566025] Starting dynamic subtest: pipe-A-valid-mode
[582.649185] Dynamic subtest pipe-A-valid-mode: SKIP (0.083s)
[582.651029] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.085s)
[582.905198] [085/131] (446s left) syncobj_eventfd (invalid-bad-pad)
[582.987373] Starting subtest: invalid-bad-pad
[582.988303] Subtest invalid-bad-pad: SUCCESS (0.000s)
[583.189518] [086/131] (445s left) kms_psr (fbc-psr-sprite-blt)
[583.373544] Subtest fbc-psr-sprite-blt: SKIP (0.000s)
[583.432907] [087/131] (445s left) gem_exec_reloc (basic-concurrent16)
[583.517749] Subtest basic-concurrent16: SKIP (0.000s)
[583.598915] [088/131] (445s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[583.787199] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[583.788937] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[583.998018] [089/131] (445s left) syncobj_wait (wait-all-interrupted)
[584.074490] Starting subtest: wait-all-interrupted
[584.177591] Subtest wait-all-interrupted: SUCCESS (0.102s)
[584.371742] [090/131] (445s left) kms_flip (flip-vs-expired-vblank)
[584.560028] Starting subtest: flip-vs-expired-vblank
[584.564642] Starting dynamic subtest: A-DP3
[592.399042] Dynamic subtest A-DP3: SUCCESS (7.834s)
[592.421532] Starting dynamic subtest: B-DP3
[600.164766] Dynamic subtest B-DP3: SUCCESS (7.764s)
[600.182884] Starting dynamic subtest: C-DP3
[607.930577] Dynamic subtest C-DP3: SUCCESS (7.764s)
[607.946513] Starting dynamic subtest: D-DP3
[615.684641] Dynamic subtest D-DP3: SUCCESS (7.752s)
[615.687041] Subtest flip-vs-expired-vblank: SUCCESS (31.125s)
[616.046971] [091/131] (413s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[616.231572] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[616.232484] Starting dynamic subtest: pipe-A-DP-3
[616.253926] Dynamic subtest pipe-A-DP-3: SKIP (0.002s)
[616.267178] Starting dynamic subtest: pipe-B-DP-3
[616.288239] Dynamic subtest pipe-B-DP-3: SKIP (0.002s)
[616.301757] Starting dynamic subtest: pipe-C-DP-3
[616.327553] Dynamic subtest pipe-C-DP-3: SKIP (0.002s)
[616.342083] Starting dynamic subtest: pipe-D-DP-3
[616.367082] Dynamic subtest pipe-D-DP-3: SKIP (0.002s)
[616.369120] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.015s)
[616.705587] [092/131] (412s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[616.890420] Starting subtest: cursorB-vs-flipA-toggle
[616.892316] Subtest cursorB-vs-flipA-toggle: SKIP (0.002s)
[617.054951] [093/131] (412s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[617.747191] Starting subtest: syncobj-stationary-timeline-chain-engines
[617.901865] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.159s)
[618.288142] [094/131] (411s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[618.367335] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[618.432635] [095/131] (411s left) gem_softpin (evict-active-interruptible)
[618.517457] Starting subtest: evict-active-interruptible
[618.532785] Subtest evict-active-interruptible: SUCCESS (0.017s)
[618.719100] [096/131] (411s left) gem_render_copy (yf-tiled-ccs-to-linear)
[618.802669] Starting subtest: yf-tiled-ccs-to-linear
[618.804643] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[619.053456] [097/131] (410s left) device_reset (unbind-reset-rebind)
[619.134586] Starting subtest: unbind-reset-rebind
[621.692904] Subtest unbind-reset-rebind: SUCCESS (2.557s)
[621.752339] [098/131] (408s left) kms_pm_dc (dc5-dpms)
[622.944429] Starting subtest: dc5-dpms
[626.723508] Subtest dc5-dpms: SUCCESS (3.778s)
[626.868174] [099/131] (403s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[627.051924] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[627.054370] Starting dynamic subtest: pipe-A-DP-3
[627.062504] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[627.076142] Starting dynamic subtest: pipe-B-DP-3
[627.084423] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[627.097887] Starting dynamic subtest: pipe-C-DP-3
[627.105924] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[627.119624] Starting dynamic subtest: pipe-D-DP-3
[627.129497] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[627.131493] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.007s)
[627.546943] [100/131] (402s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[627.739698] Starting subtest: yf-tiled-64bpp-rotate-90
[627.741585] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[627.945561] [101/131] (402s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[628.142054] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[628.143699] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[628.345766] [102/131] (401s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render)
[628.537950] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render
[628.539527] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[628.745367] [103/131] (401s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[628.936964] Starting subtest: fbc-indfb-scaledprimary
[630.460771] Subtest fbc-indfb-scaledprimary: SUCCESS (1.524s)
[630.730632] [104/131] (399s left) vgem_basic (create)
[630.793598] Starting subtest: create
[630.794546] Subtest create: SUCCESS (0.000s)
[630.953349] [105/131] (399s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[631.148379] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[631.150096] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[631.347595] [106/131] (399s left) gem_exec_fence (basic-await)
[631.549838] Starting subtest: basic-await
[631.550751] Starting dynamic subtest: rcs0
[631.667891] Dynamic subtest rcs0: SUCCESS (0.117s)
[631.684614] Starting dynamic subtest: bcs0
[631.755513] Dynamic subtest bcs0: SUCCESS (0.086s)
[631.771390] Starting dynamic subtest: vcs0
[631.841106] Dynamic subtest vcs0: SUCCESS (0.084s)
[631.859312] Starting dynamic subtest: vcs1
[631.930013] Dynamic subtest vcs1: SUCCESS (0.088s)
[631.949650] Starting dynamic subtest: vecs0
[632.021517] Dynamic subtest vecs0: SUCCESS (0.090s)
[632.040496] Starting dynamic subtest: vecs1
[632.111353] Dynamic subtest vecs1: SUCCESS (0.088s)
[632.128265] Starting dynamic subtest: ccs0
[632.198247] Dynamic subtest ccs0: SUCCESS (0.086s)
[632.199283] Subtest basic-await: SUCCESS (0.649s)
[633.030002] [107/131] (397s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[633.223031] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[636.010712] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (2.788s)
[636.226652] [108/131] (394s left) kms_ccs (bad-aux-stride-yf-tiled-ccs)
[636.427401] Starting subtest: bad-aux-stride-yf-tiled-ccs
[636.428307] Starting dynamic subtest: pipe-A-DP-3
[636.436512] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[636.450161] Starting dynamic subtest: pipe-B-DP-3
[636.458449] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[636.471931] Starting dynamic subtest: pipe-C-DP-3
[636.480120] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[636.493892] Starting dynamic subtest: pipe-D-DP-3
[636.503675] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[636.505658] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.007s)
[636.905094] [109/131] (393s left) gem_userptr_blits (create-destroy-unsync)
[636.991769] Subtest create-destroy-unsync: SKIP (0.000s)
[637.175101] [110/131] (393s left) kms_pm_rpm (universal-planes)
[639.475431] Starting subtest: universal-planes
[639.476695] Starting dynamic subtest: plane-33
[642.263820] Dynamic subtest plane-33: SUCCESS (2.787s)
[642.314684] Starting dynamic subtest: plane-63
[644.967474] Dynamic subtest plane-63: SUCCESS (2.699s)
[645.018688] Starting dynamic subtest: plane-93
[647.663546] Dynamic subtest plane-93: SUCCESS (2.690s)
[647.681597] Starting dynamic subtest: plane-123
[650.446387] Dynamic subtest plane-123: SUCCESS (2.779s)
[650.499140] Starting dynamic subtest: plane-133
[653.170652] Dynamic subtest plane-133: SUCCESS (2.719s)
[653.218292] Starting dynamic subtest: plane-143
[655.988790] Dynamic subtest plane-143: SUCCESS (2.813s)
[655.994399] Subtest universal-planes: SUCCESS (16.515s)
[656.438125] [111/131] (374s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[656.622539] Starting subtest: 2x-flip-vs-cursor-atomic
[656.624353] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.002s)
[656.797163] [112/131] (374s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[656.988241] Starting subtest: psr-rgb565-draw-blt
[656.989982] Subtest psr-rgb565-draw-blt: SKIP (0.000s)
[657.193478] [113/131] (373s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[657.382147] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[657.383950] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[657.575779] [114/131] (373s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[657.760673] Starting subtest: plane-upscale-20x20-with-rotation
[657.761599] Starting dynamic subtest: pipe-A
[658.155060] Dynamic subtest pipe-A: SUCCESS (0.394s)
[658.180644] Starting dynamic subtest: pipe-B
[658.615587] Dynamic subtest pipe-B: SUCCESS (0.459s)
[658.642659] Starting dynamic subtest: pipe-C
[659.096778] Dynamic subtest pipe-C: SUCCESS (0.480s)
[659.130696] Starting dynamic subtest: pipe-D
[659.574847] Dynamic subtest pipe-D: SUCCESS (0.476s)
[659.576214] Subtest plane-upscale-20x20-with-rotation: SUCCESS (1.815s)
[659.941421] [115/131] (371s left) gem_busy (busy)
[660.031515] Starting subtest: busy
[660.032486] Starting dynamic subtest: all-engines
[660.129733] Dynamic subtest all-engines: SUCCESS (0.098s)
[660.148321] Starting dynamic subtest: rcs0
[660.258053] Dynamic subtest rcs0: SUCCESS (0.127s)
[660.273877] Starting dynamic subtest: bcs0
[660.306644] Dynamic subtest bcs0: SUCCESS (0.047s)
[660.327782] Starting dynamic subtest: vcs0
[660.345921] Dynamic subtest vcs0: SUCCESS (0.038s)
[660.367313] Starting dynamic subtest: vcs1
[660.385678] Dynamic subtest vcs1: SUCCESS (0.039s)
[660.406248] Starting dynamic subtest: vecs0
[660.425605] Dynamic subtest vecs0: SUCCESS (0.039s)
[660.444085] Starting dynamic subtest: vecs1
[660.464620] Dynamic subtest vecs1: SUCCESS (0.038s)
[660.481487] Starting dynamic subtest: ccs0
[660.503637] Dynamic subtest ccs0: SUCCESS (0.038s)
[660.504575] Subtest busy: SUCCESS (0.473s)
[660.974415] [116/131] (370s left) kms_legacy_colorkey (invalid-plane)
[661.160533] Starting subtest: invalid-plane
[661.161404] Starting dynamic subtest: zero-id
[661.162324] Dynamic subtest zero-id: SUCCESS (0.000s)
[661.176303] Starting dynamic subtest: outrange-id
[661.177513] Dynamic subtest outrange-id: SUCCESS (0.000s)
[661.178774] Subtest invalid-plane: SUCCESS (0.002s)
[661.327343] [117/131] (370s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[661.407558] Subtest basic-wc-gtt-noreloc: SKIP (0.000s)
[661.484067] [118/131] (370s left) api_intel_bb (object-noreloc-keep-cache-simple)
[661.559662] Starting subtest: object-noreloc-keep-cache-simple
[661.591653] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.032s)
[661.841587] [119/131] (369s left) gem_close_race (multigpu-basic-process)
[661.955450] Starting subtest: multigpu-basic-process
[661.957391] Subtest multigpu-basic-process: SKIP (0.000s)
[662.291811] [120/131] (369s left) kms_flip (nonblocking-read)
[662.477078] Starting subtest: nonblocking-read
[662.477916] Subtest nonblocking-read: SUCCESS (0.000s)
[662.692361] [121/131] (369s left) intel_hwmon (hwmon-write)
[662.774648] Starting subtest: hwmon-write
[662.791094] Subtest hwmon-write: SUCCESS (0.016s)
[662.933700] [122/131] (368s left) gem_lmem_swapping (random)
[665.634502] Starting subtest: random
[665.635397] Starting dynamic subtest: lmem0
[666.584198] Dynamic subtest lmem0: SUCCESS (0.950s)
[666.585560] Subtest random: SUCCESS (0.951s)
[669.597235] [FACT gem_lmem_swapping (random)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[669.598180] [FACT gem_lmem_swapping (random)] deleted: kernel.kmod_is_loaded.i915: true
[669.600007] [123/131] (362s left) kms_feature_discovery (display-2x)
[671.278429] Starting subtest: display-2x
[671.280190] Subtest display-2x: SKIP (0.000s)
[671.332832] [FACT kms_feature_discovery (display-2x)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[671.335135] [FACT kms_feature_discovery (display-2x)] new: kernel.kmod_is_loaded.i915: true
[671.337822] [124/131] (360s left) gem_mmap_gtt (basic-small-copy-xy)
[671.418324] Subtest basic-small-copy-XY: SKIP (0.000s)
[671.485250] [125/131] (360s left) perf (gen12-mi-rpc)
[671.868436] Starting subtest: gen12-mi-rpc
[671.869290] Starting dynamic subtest: rcs0
[671.933855] Dynamic subtest rcs0: SUCCESS (0.065s)
[671.934722] Subtest gen12-mi-rpc: SUCCESS (0.066s)
[671.988707] [126/131] (360s left) i915_pm_rc6_residency (rc6-fence)
[672.101800] Starting subtest: rc6-fence
[672.125667] Starting dynamic subtest: gt0
[696.649241] Dynamic subtest gt0: SUCCESS (24.522s)
[696.653690] Subtest rc6-fence: SUCCESS (24.549s)
[696.827258] [127/131] (335s left) kms_addfb_basic (basic)
[696.910080] Starting subtest: basic
[696.911079] Subtest basic: SUCCESS (0.000s)
[697.206538] [128/131] (335s left) gem_mmap_offset (clear)
[697.281443] Starting subtest: clear
[697.282331] Starting dynamic subtest: lmem0
[722.311141] Dynamic subtest lmem0: SUCCESS (25.024s)
[722.327098] Starting dynamic subtest: smem0
[746.406489] Dynamic subtest smem0: SUCCESS (24.097s)
[746.408636] Subtest clear: SUCCESS (49.123s)
[746.667497] [129/131] (285s left) gem_ctx_param (basic-default)
[746.784702] Starting subtest: basic-default
[746.785721] Subtest basic-default: SUCCESS (0.000s)
[746.950985] [130/131] (285s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[747.144554] Starting subtest: cursor-vs-flip-varying-size
[779.924437] Subtest cursor-vs-flip-varying-size: SUCCESS (32.779s)
[780.235758] [131/131] (252s left) api_intel_bb (blit-noreloc-purge-cache)
[780.312651] Starting subtest: blit-noreloc-purge-cache
[780.349485] Subtest blit-noreloc-purge-cache: SUCCESS (0.038s)
[780.501926] Closing watchdogs
results: parsing output: 0/ for test: kms_atomic
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_ccs
results: parsing output: 3/ for test: syncobj_timeline
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: kms_feature_discovery
results: parsing output: 7/ for test: gen9_exec_parse
results: parsing output: 8/ for test: sw_sync
results: parsing output: 9/ for test: kms_lease
results: parsing output: 10/ for test: gem_pwrite
results: parsing output: 11/ for test: kms_psr
results: parsing output: 12/ for test: i915_drm_fdinfo
results: parsing output: 13/ for test: gem_exec_whisper
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_cursor_crc
results: parsing output: 17/ for test: kms_getfb
results: parsing output: 18/ for test: syncobj_timeline
results: parsing output: 19/ for test: kms_vblank
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: gem_ctx_shared
results: parsing output: 22/ for test: kms_flip
results: parsing output: 23/ for test: gem_ctx_persistence
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: syncobj_timeline
results: parsing output: 26/ for test: kms_plane_scaling
results: parsing output: 27/ for test: syncobj_timeline
results: parsing output: 28/ for test: gen3_render_linear_blits
results: parsing output: 29/ for test: gem_exec_schedule
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: i915_suspend
results: parsing output: 32/ for test: gem_tiled_pread_pwrite
results: parsing output: 33/ for test: gem_exec_params
results: parsing output: 34/ for test: syncobj_wait
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_spin_batch
results: parsing output: 38/ for test: perf_pmu
results: parsing output: 39/ for test: perf
results: parsing output: 40/ for test: gem_exec_schedule
results: parsing output: 41/ for test: gem_lmem_swapping
results: parsing output: 42/ for test: syncobj_wait
results: parsing output: 43/ for test: syncobj_timeline
results: parsing output: 44/ for test: kms_vblank
results: parsing output: 45/ for test: kms_cursor_legacy
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_chamelium_hpd
results: parsing output: 48/ for test: kms_big_fb
results: parsing output: 49/ for test: kms_fence_pin_leak
results: parsing output: 50/ for test: gem_tiling_max_stride
results: parsing output: 51/ for test: kms_invalid_mode
results: parsing output: 52/ for test: i915_drm_fdinfo
results: parsing output: 53/ for test: syncobj_wait
results: parsing output: 54/ for test: gem_mmap_gtt
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: kms_psr2_sf
results: parsing output: 57/ for test: kms_psr
results: parsing output: 58/ for test: kms_flip
results: parsing output: 59/ for test: kms_psr2_sf
results: parsing output: 60/ for test: kms_chamelium_color
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_content_protection
results: parsing output: 63/ for test: kms_psr
results: parsing output: 64/ for test: kms_properties
results: parsing output: 65/ for test: gem_ringfill
results: parsing output: 66/ for test: gem_watchdog
results: parsing output: 67/ for test: kms_dp_aux_dev
results: parsing output: 68/ for test: kms_chamelium_edid
results: parsing output: 69/ for test: kms_fbcon_fbt
results: parsing output: 70/ for test: syncobj_timeline
results: parsing output: 71/ for test: gem_exec_reloc
results: parsing output: 72/ for test: gem_workarounds
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_cursor_legacy
results: parsing output: 75/ for test: gem_ctx_persistence
results: parsing output: 76/ for test: kms_psr
results: parsing output: 77/ for test: kms_cursor_crc
results: parsing output: 78/ for test: kms_force_connector_basic
results: parsing output: 79/ for test: kms_cursor_crc
results: parsing output: 80/ for test: kms_plane_cursor
results: parsing output: 81/ for test: gem_exec_balancer
results: parsing output: 82/ for test: kms_ccs
results: parsing output: 83/ for test: kms_flip_scaled_crc
results: parsing output: 84/ for test: syncobj_eventfd
results: parsing output: 85/ for test: kms_psr
results: parsing output: 86/ for test: gem_exec_reloc
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: syncobj_wait
results: parsing output: 89/ for test: kms_flip
results: parsing output: 90/ for test: kms_ccs
results: parsing output: 91/ for test: kms_cursor_legacy
results: parsing output: 92/ for test: gem_exec_fence
results: parsing output: 93/ for test: gem_mmap_gtt
results: parsing output: 94/ for test: gem_softpin
results: parsing output: 95/ for test: gem_render_copy
results: parsing output: 96/ for test: device_reset
results: parsing output: 97/ for test: kms_pm_dc
results: parsing output: 98/ for test: kms_ccs
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_frontbuffer_tracking
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: vgem_basic
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: gem_exec_fence
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: gem_userptr_blits
results: parsing output: 109/ for test: kms_pm_rpm
results: parsing output: 110/ for test: kms_cursor_legacy
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_plane_scaling
results: parsing output: 114/ for test: gem_busy
results: parsing output: 115/ for test: kms_legacy_colorkey
results: parsing output: 116/ for test: gem_exec_reloc
results: parsing output: 117/ for test: api_intel_bb
results: parsing output: 118/ for test: gem_close_race
results: parsing output: 119/ for test: kms_flip
results: parsing output: 120/ for test: intel_hwmon
results: parsing output: 121/ for test: gem_lmem_swapping
results: parsing output: 122/ for test: kms_feature_discovery
results: parsing output: 123/ for test: gem_mmap_gtt
results: parsing output: 124/ for test: perf
results: parsing output: 125/ for test: i915_pm_rc6_residency
results: parsing output: 126/ for test: kms_addfb_basic
results: parsing output: 127/ for test: gem_mmap_offset
results: parsing output: 128/ for test: gem_ctx_param
results: parsing output: 129/ for test: kms_cursor_legacy
results: parsing output: 130/ for test: api_intel_bb
Done.