[60.194899] Initializing watchdogs
[60.194964]   /dev/watchdog0
[60.214944] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[60.225112] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[60.229191] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.231634] [001/131] (960s left) kms_pm_rpm (cursor-dpms)
[62.065982] Starting subtest: cursor-dpms
[62.069587] Subtest cursor-dpms: SKIP (0.000s)
[62.473680] [002/131] (958s left) gem_exec_async (forked-writes)
[62.557101] Starting subtest: forked-writes
[62.558055] Starting dynamic subtest: rcs0
[62.621408] Dynamic subtest rcs0: SUCCESS (0.064s)
[62.632374] Starting dynamic subtest: bcs0
[62.658082] Dynamic subtest bcs0: SUCCESS (0.036s)
[62.666286] Starting dynamic subtest: vcs0
[62.696201] Dynamic subtest vcs0: SUCCESS (0.038s)
[62.704419] Starting dynamic subtest: vcs1
[62.729844] Dynamic subtest vcs1: SUCCESS (0.033s)
[62.738645] Starting dynamic subtest: vecs0
[62.763800] Dynamic subtest vecs0: SUCCESS (0.034s)
[62.771945] Starting dynamic subtest: vecs1
[62.796376] Dynamic subtest vecs1: SUCCESS (0.032s)
[62.804932] Starting dynamic subtest: ccs0
[62.829293] Dynamic subtest ccs0: SUCCESS (0.033s)
[62.830605] Subtest forked-writes: SUCCESS (0.272s)
[63.168524] [003/131] (957s left) kms_cursor_crc (cursor-onscreen-512x512)
[63.618911] Starting subtest: cursor-onscreen-512x512
[63.620665] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[63.903327] [004/131] (957s left) perf_pmu (frequency)
[63.965389] Starting subtest: frequency
[63.968562] Starting dynamic subtest: gt0
[66.267244] Dynamic subtest gt0: FAIL (2.208s)
[66.303180] Starting dynamic subtest: idle-gt0
[66.682769] Dynamic subtest idle-gt0: SUCCESS (0.504s)
[66.683592] Subtest frequency: FAIL (2.717s)
[66.850276] [005/131] (954s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[67.215145] Starting subtest: plane-primary-toggle-with-vblank-wait
[67.216208] Starting dynamic subtest: pipe-A-DP-3
[67.456314] Dynamic subtest pipe-A-DP-3: SUCCESS (0.241s)
[67.555602] Starting dynamic subtest: pipe-B-DP-3
[67.814312] Dynamic subtest pipe-B-DP-3: SUCCESS (0.267s)
[67.871343] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (0.657s)
[68.235953] [006/131] (952s left) gem_ctx_persistence (legacy-engines-queued)
[68.313244] Starting subtest: legacy-engines-queued
[68.314183] Starting dynamic subtest: render
[68.415326] Dynamic subtest render: SUCCESS (0.102s)
[68.425568] Starting dynamic subtest: bsd1
[68.471281] Dynamic subtest bsd1: SUCCESS (0.055s)
[68.484155] Starting dynamic subtest: bsd2
[68.503310] Dynamic subtest bsd2: SUCCESS (0.031s)
[68.516175] Starting dynamic subtest: blt
[68.572501] Dynamic subtest blt: SUCCESS (0.069s)
[68.590176] Starting dynamic subtest: vebox
[68.655777] Dynamic subtest vebox: SUCCESS (0.082s)
[68.657283] Subtest legacy-engines-queued: SUCCESS (0.343s)
[68.868953] [007/131] (952s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs)
[69.049250] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs
[69.050180] Starting dynamic subtest: pipe-A-DP-3
[69.071305] Dynamic subtest pipe-A-DP-3: SKIP (0.002s)
[69.080257] Starting dynamic subtest: pipe-B-DP-3
[69.101364] Dynamic subtest pipe-B-DP-3: SKIP (0.002s)
[69.110223] Starting dynamic subtest: pipe-C-DP-3
[69.134292] Dynamic subtest pipe-C-DP-3: SKIP (0.002s)
[69.143286] Starting dynamic subtest: pipe-D-DP-3
[69.164762] Dynamic subtest pipe-D-DP-3: SKIP (0.002s)
[69.166780] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.011s)
[69.510562] [008/131] (951s left) kms_content_protection (lic-type-1)
[69.751868] Starting subtest: lic-type-1
[69.757880] Subtest lic-type-1: SKIP (0.003s)
[69.989698] [009/131] (951s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[70.176276] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[70.177998] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[70.339827] [010/131] (951s left) kms_display_modes (extended-mode-basic)
[70.518213] Starting subtest: extended-mode-basic
[70.521782] Subtest extended-mode-basic: SKIP (0.000s)
[70.572629] [011/131] (950s left) gem_exec_schedule (u-lateslice)
[70.655192] Starting subtest: u-lateslice
[70.656152] Starting dynamic subtest: rcs0
[70.706270] Dynamic subtest rcs0: SUCCESS (0.051s)
[70.715665] Starting dynamic subtest: bcs0
[70.726141] Dynamic subtest bcs0: SUCCESS (0.020s)
[70.735375] Starting dynamic subtest: vcs0
[70.750475] Dynamic subtest vcs0: SUCCESS (0.024s)
[70.759783] Starting dynamic subtest: vcs1
[70.770580] Dynamic subtest vcs1: SUCCESS (0.020s)
[70.779755] Starting dynamic subtest: vecs0
[70.792177] Dynamic subtest vecs0: SUCCESS (0.021s)
[70.801399] Starting dynamic subtest: vecs1
[70.814818] Dynamic subtest vecs1: SUCCESS (0.022s)
[70.824258] Starting dynamic subtest: ccs0
[70.836059] Dynamic subtest ccs0: SUCCESS (0.021s)
[70.837066] Subtest u-lateslice: SUCCESS (0.181s)
[71.296818] [012/131] (950s left) kms_flip_event_leak (basic)
[71.473301] Starting subtest: basic
[71.474210] Starting dynamic subtest: pipe-A-DP-3
[71.793146] Dynamic subtest pipe-A-DP-3: SUCCESS (0.318s)
[71.806344] Starting dynamic subtest: pipe-B-DP-3
[72.078658] Dynamic subtest pipe-B-DP-3: SUCCESS (0.285s)
[72.095987] Starting dynamic subtest: pipe-C-DP-3
[72.359143] Dynamic subtest pipe-C-DP-3: SUCCESS (0.278s)
[72.375609] Starting dynamic subtest: pipe-D-DP-3
[72.642594] Dynamic subtest pipe-D-DP-3: SUCCESS (0.282s)
[72.643531] Subtest basic: SUCCESS (1.169s)
[72.940885] [013/131] (948s left) gem_ccs (block-copy-compressed)
[73.016874] Starting subtest: block-copy-compressed
[73.017825] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0
[73.067194] Dynamic subtest linear-compressed-compfmt0-smem-lmem0: SUCCESS (0.050s)
[73.077083] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0
[73.168627] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.101s)
[73.177611] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0
[73.185936] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0: SUCCESS (0.017s)
[73.195235] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0
[73.296593] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.110s)
[73.305621] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0
[73.314973] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0: SUCCESS (0.018s)
[73.324583] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0
[73.416932] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.102s)
[73.426365] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0
[73.434201] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0: SUCCESS (0.017s)
[73.443539] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0
[73.536354] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.102s)
[73.537408] Subtest block-copy-compressed: SUCCESS (0.520s)
[73.765591] [014/131] (947s left) kms_getfb (getfb2-handle-protection)
[73.957229] Starting subtest: getfb2-handle-protection
[73.970188] Subtest getfb2-handle-protection: SUCCESS (0.013s)
[74.171255] [015/131] (947s left) gem_exec_fence (invalid-timeline-fence-array)
[74.839207] Starting subtest: invalid-timeline-fence-array
[74.840517] Subtest invalid-timeline-fence-array: SUCCESS (0.005s)
[75.105527] [FACT gem_exec_fence (invalid-timeline-fence-array)] new: kernel.kmod_is_loaded.vgem: true
[75.107141] [016/131] (946s left) kms_psr (fbc-psr-primary-mmap-gtt)
[75.298676] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.000s)
[75.352924] [017/131] (946s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[75.549385] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.000s)
[75.602716] [018/131] (946s left) syncobj_wait (wait-any-interrupted)
[75.680925] Starting subtest: wait-any-interrupted
[75.782407] Subtest wait-any-interrupted: SUCCESS (0.101s)
[75.961819] [019/131] (946s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs)
[76.159437] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs
[76.160364] Starting dynamic subtest: pipe-A-DP-3
[76.168592] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[76.178126] Starting dynamic subtest: pipe-B-DP-3
[76.186134] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[76.195384] Starting dynamic subtest: pipe-C-DP-3
[76.203316] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[76.212328] Starting dynamic subtest: pipe-D-DP-3
[76.221826] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[76.223894] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[76.598827] [020/131] (945s left) gem_eio (unwedge-stress)
[76.876448] Starting subtest: unwedge-stress
[76.877441] Starting dynamic subtest: render
[94.957389] Dynamic subtest render: SUCCESS (18.080s)
[94.968167] Starting dynamic subtest: bsd1
[112.937497] Dynamic subtest bsd1: SUCCESS (17.980s)
[112.948183] Starting dynamic subtest: bsd2
[130.908398] Dynamic subtest bsd2: SUCCESS (17.970s)
[130.919173] Starting dynamic subtest: blt
[148.982519] Dynamic subtest blt: SUCCESS (18.074s)
[148.992751] Starting dynamic subtest: vebox
[166.952731] Dynamic subtest vebox: SUCCESS (17.969s)
[166.953461] Subtest unwedge-stress: SUCCESS (90.074s)
[167.274642] [021/131] (854s left) perf_pmu (busy-hang)
[167.344352] Starting subtest: busy-hang
[167.345308] Starting dynamic subtest: rcs0
[168.666639] Dynamic subtest rcs0: SUCCESS (1.320s)
[168.676782] Starting dynamic subtest: bcs0
[169.897658] Dynamic subtest bcs0: SUCCESS (1.230s)
[169.908247] Starting dynamic subtest: vcs0
[171.137530] Dynamic subtest vcs0: SUCCESS (1.239s)
[171.147539] Starting dynamic subtest: vcs1
[172.384702] Dynamic subtest vcs1: SUCCESS (1.248s)
[172.396501] Starting dynamic subtest: vecs0
[173.635600] Dynamic subtest vecs0: SUCCESS (1.248s)
[173.646216] Starting dynamic subtest: vecs1
[174.881815] Dynamic subtest vecs1: SUCCESS (1.247s)
[174.893232] Starting dynamic subtest: ccs0
[176.122592] Dynamic subtest ccs0: SUCCESS (1.238s)
[176.123543] Subtest busy-hang: SUCCESS (8.776s)
[176.302642] [022/131] (845s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[176.378954] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[176.379902] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[176.573497] [023/131] (845s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[176.755294] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[176.756218] Starting dynamic subtest: pipe-A-valid-mode
[176.832555] Dynamic subtest pipe-A-valid-mode: SKIP (0.076s)
[176.834214] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.077s)
[177.082082] [024/131] (845s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[177.268925] Starting subtest: cursor-vs-flip-legacy
[207.526280] Subtest cursor-vs-flip-legacy: SUCCESS (30.257s)
[207.842124] [025/131] (814s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[208.026404] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[208.028125] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[208.214969] [026/131] (814s left) syncobj_basic (bad-handle-to-fd)
[208.288978] Starting subtest: bad-handle-to-fd
[208.289983] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[208.455544] [027/131] (814s left) kms_content_protection (srm)
[208.704585] Starting subtest: srm
[208.730995] Starting dynamic subtest: pipe-A-DP-3
[329.685052] Dynamic subtest pipe-A-DP-3: FAIL (120.780s)
[329.686783] Subtest srm: FAIL (120.905s)
[329.944299] [028/131] (692s left) kms_properties (get_properties-sanity-atomic)
[330.127421] Starting subtest: get_properties-sanity-atomic
[330.131038] Subtest get_properties-sanity-atomic: SUCCESS (0.004s)
[330.294709] [029/131] (692s left) gem_request_retire (retire-vma-not-inactive)
[330.375546] Starting subtest: retire-vma-not-inactive
[330.457446] Subtest retire-vma-not-inactive: SUCCESS (0.082s)
[330.627180] [030/131] (692s left) kms_rotation_crc (primary-rotation-180)
[330.809570] Starting subtest: primary-rotation-180
[341.175355] Subtest primary-rotation-180: SUCCESS (10.365s)
[341.583612] [031/131] (681s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[341.769330] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[341.770274] Starting dynamic subtest: pipe-A-DP-3
[341.773569] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[341.783894] Starting dynamic subtest: pipe-B-DP-3
[341.787269] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[341.797425] Starting dynamic subtest: pipe-C-DP-3
[341.800971] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[341.811039] Starting dynamic subtest: pipe-D-DP-3
[341.814328] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[341.815989] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SKIP (0.005s)
[342.254627] [032/131] (680s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[342.328039] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[342.399971] [033/131] (680s left) gem_shrink (reclaim)
[342.482063] Starting subtest: reclaim
[344.736331] Subtest reclaim: SUCCESS (2.254s)
[344.922557] [034/131] (678s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[345.037192] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[345.140403] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.104s)
[345.317709] [035/131] (677s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[345.515588] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[345.517315] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[345.702564] [036/131] (677s left) kms_dsc (dsc-fractional-bpp)
[345.885983] Starting subtest: dsc-fractional-bpp
[345.890893] Subtest dsc-fractional-bpp: SKIP (0.001s)
[346.035522] [037/131] (677s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[346.221781] Starting subtest: cursorB-vs-flipB-atomic
[346.224937] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[346.395739] [038/131] (677s left) prime_vgem (fence-flip-hang)
[346.493843] Subtest fence-flip-hang: SKIP (0.000s)
[346.669898] [039/131] (676s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[346.861580] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[346.863208] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[347.056037] [040/131] (676s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[347.245889] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[347.246729] Starting dynamic subtest: pipe-A
[347.357134] Dynamic subtest pipe-A: SUCCESS (0.112s)
[347.383060] Starting dynamic subtest: pipe-B
[347.586610] Dynamic subtest pipe-B: SUCCESS (0.229s)
[347.598369] Starting dynamic subtest: pipe-C
[347.781825] Dynamic subtest pipe-C: SUCCESS (0.195s)
[347.799062] Starting dynamic subtest: pipe-D
[347.993818] Dynamic subtest pipe-D: SUCCESS (0.211s)
[347.994809] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SUCCESS (0.749s)
[348.353200] [041/131] (675s left) gem_mmap (pf-nonblock)
[348.428991] Subtest pf-nonblock: SKIP (0.000s)
[348.497494] [042/131] (675s left) kms_plane_multiple (tiling-y)
[348.682055] Starting subtest: tiling-y
[348.683613] Subtest tiling-y: SKIP (0.000s)
[348.840240] [043/131] (674s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[349.032795] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[349.034528] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[349.239301] [044/131] (674s left) kms_async_flips (alternate-sync-async-flip-atomic)
[349.429951] Starting subtest: alternate-sync-async-flip-atomic
[349.655145] Starting dynamic subtest: pipe-A-DP-3
[351.956443] Dynamic subtest pipe-A-DP-3: SUCCESS (2.301s)
[352.202405] Starting dynamic subtest: pipe-B-DP-3
[354.313692] Dynamic subtest pipe-B-DP-3: SUCCESS (2.122s)
[354.525152] Starting dynamic subtest: pipe-C-DP-3
[356.644626] Dynamic subtest pipe-C-DP-3: SUCCESS (2.128s)
[356.852144] Starting dynamic subtest: pipe-D-DP-3
[358.970644] Dynamic subtest pipe-D-DP-3: SUCCESS (2.128s)
[358.971604] Subtest alternate-sync-async-flip-atomic: SUCCESS (9.541s)
[359.485120] [045/131] (664s left) perf (polling)
[359.911389] Starting subtest: polling
[359.912272] Starting dynamic subtest: 0-rcs0
[369.950770] Dynamic subtest 0-rcs0: SUCCESS (10.039s)
[369.951632] Subtest polling: SUCCESS (10.040s)
[370.026892] [046/131] (654s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[370.223982] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[370.225697] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[370.412147] [047/131] (653s left) gem_exec_schedule (preempt-engines)
[370.504360] Starting subtest: preempt-engines
[370.505345] Starting dynamic subtest: rcs0
[372.729912] Dynamic subtest rcs0: SUCCESS (2.224s)
[372.745915] Starting dynamic subtest: bcs0
[374.902119] Dynamic subtest bcs0: SUCCESS (2.169s)
[374.918377] Starting dynamic subtest: vcs0
[377.176090] Dynamic subtest vcs0: SUCCESS (2.270s)
[377.192380] Starting dynamic subtest: vcs1
[379.450435] Dynamic subtest vcs1: SUCCESS (2.271s)
[379.466158] Starting dynamic subtest: vecs0
[381.723652] Dynamic subtest vecs0: SUCCESS (2.270s)
[381.739918] Starting dynamic subtest: vecs1
[383.995408] Dynamic subtest vecs1: SUCCESS (2.268s)
[384.011215] Starting dynamic subtest: ccs0
[386.203393] Dynamic subtest ccs0: SUCCESS (2.204s)
[386.205360] Subtest preempt-engines: SUCCESS (15.700s)
[386.654800] [048/131] (637s left) gem_create (create-valid-nonaligned)
[386.731286] Starting subtest: create-valid-nonaligned
[386.732227] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[387.001211] [049/131] (637s left) gem_spin_batch (spin-all)
[387.093749] Starting subtest: spin-all
[387.139196] Subtest spin-all: SUCCESS (0.046s)
[387.424971] [050/131] (636s left) kms_addfb_basic (tile-pitch-mismatch)
[387.502427] Starting subtest: tile-pitch-mismatch
[387.504180] Subtest tile-pitch-mismatch: SKIP (0.000s)
[387.799498] [051/131] (636s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[387.878218] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[387.879176] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[388.071881] [052/131] (636s left) gem_mmap_gtt (basic-write-gtt)
[388.150025] Subtest basic-write-gtt: SKIP (0.000s)
[388.236983] [053/131] (636s left) kms_sequence (queue-idle)
[388.423174] Starting subtest: queue-idle
[388.424156] Starting dynamic subtest: pipe-A-DP-3
[390.793984] Dynamic subtest pipe-A-DP-3: SUCCESS (2.371s)
[390.806155] Starting dynamic subtest: pipe-B-DP-3
[393.091451] Dynamic subtest pipe-B-DP-3: SUCCESS (2.295s)
[393.103812] Starting dynamic subtest: pipe-C-DP-3
[395.379398] Dynamic subtest pipe-C-DP-3: SUCCESS (2.286s)
[395.390547] Starting dynamic subtest: pipe-D-DP-3
[397.668482] Dynamic subtest pipe-D-DP-3: SUCCESS (2.288s)
[397.669445] Subtest queue-idle: SUCCESS (9.247s)
[397.994807] [054/131] (626s left) kms_psr (psr2-primary-mmap-gtt)
[398.180567] Subtest psr2-primary-mmap-gtt: SKIP (0.000s)
[398.235768] [055/131] (626s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[398.439990] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[399.592732] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (1.153s)
[399.861396] [056/131] (624s left) gem_ctx_bad_destroy (double-destroy)
[399.940601] Starting subtest: double-destroy
[399.941486] Subtest double-destroy: SUCCESS (0.000s)
[400.089059] [057/131] (624s left) gem_ctx_persistence (engines-hostile)
[400.178011] Starting subtest: engines-hostile
[400.178941] Starting dynamic subtest: rcs0
[400.339473] Dynamic subtest rcs0: SUCCESS (0.160s)
[400.358183] Starting dynamic subtest: bcs0
[400.385279] Dynamic subtest bcs0: SUCCESS (0.043s)
[400.398798] Starting dynamic subtest: vcs0
[400.480182] Dynamic subtest vcs0: SUCCESS (0.093s)
[400.525544] Starting dynamic subtest: vcs1
[400.536254] Dynamic subtest vcs1: SUCCESS (0.053s)
[400.554186] Starting dynamic subtest: vecs0
[400.581197] Dynamic subtest vecs0: SUCCESS (0.044s)
[400.594412] Starting dynamic subtest: vecs1
[400.672132] Dynamic subtest vecs1: SUCCESS (0.089s)
[400.717561] Starting dynamic subtest: ccs0
[400.733246] Dynamic subtest ccs0: SUCCESS (0.058s)
[400.734313] Subtest engines-hostile: SUCCESS (0.556s)
[400.942710] [058/131] (624s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[401.133164] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[401.137904] Starting dynamic subtest: A-DP3
[409.225052] Dynamic subtest A-DP3: SUCCESS (8.086s)
[409.239568] Starting dynamic subtest: B-DP3
[417.247982] Dynamic subtest B-DP3: SUCCESS (8.019s)
[417.260479] Starting dynamic subtest: C-DP3
[425.277918] Dynamic subtest C-DP3: SUCCESS (8.029s)
[425.290598] Starting dynamic subtest: D-DP3
[433.283324] Dynamic subtest D-DP3: SUCCESS (8.003s)
[433.288334] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (32.155s)
[433.630369] [059/131] (591s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[433.819259] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[433.821027] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[434.161812] [060/131] (590s left) kms_plane_alpha_blend (alpha-transparent-fb)
[434.346402] Starting subtest: alpha-transparent-fb
[434.606800] Starting dynamic subtest: pipe-A-DP-3
[435.103808] Dynamic subtest pipe-A-DP-3: SUCCESS (0.496s)
[435.115410] Starting dynamic subtest: pipe-D-DP-3
[435.675213] Dynamic subtest pipe-D-DP-3: SUCCESS (0.570s)
[435.676163] Subtest alpha-transparent-fb: SUCCESS (1.329s)
[436.013788] [061/131] (589s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[436.202851] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[436.204491] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[436.412489] [062/131] (588s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[436.605402] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[436.655263] [063/131] (588s left) kms_prop_blob (invalid-set-prop)
[436.735253] Starting subtest: invalid-set-prop
[436.736151] Subtest invalid-set-prop: SUCCESS (0.000s)
[436.928291] [064/131] (588s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[437.120896] Starting subtest: fbcpsr-rgb565-draw-pwrite
[437.122519] Subtest fbcpsr-rgb565-draw-pwrite: SKIP (0.000s)
[437.312824] [065/131] (588s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[437.495752] Starting subtest: random-ccs-data-yf-tiled-ccs
[437.498169] Starting dynamic subtest: pipe-A-DP-3
[437.507062] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[437.517480] Starting dynamic subtest: pipe-B-DP-3
[437.526551] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[437.536718] Starting dynamic subtest: pipe-C-DP-3
[437.545495] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[437.555877] Starting dynamic subtest: pipe-D-DP-3
[437.567057] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[437.568651] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.007s)
[437.988477] [066/131] (587s left) i915_query (engine-info-invalid)
[438.076226] Starting subtest: engine-info-invalid
[438.077165] Subtest engine-info-invalid: SUCCESS (0.000s)
[438.267117] [067/131] (587s left) kms_atomic_interruptible (legacy-dpms)
[438.452397] Starting subtest: legacy-dpms
[438.453276] Starting dynamic subtest: pipe-A-DP-3
[444.773556] Dynamic subtest pipe-A-DP-3: SUCCESS (6.320s)
[444.774527] Subtest legacy-dpms: SUCCESS (6.322s)
[445.055026] [068/131] (580s left) kms_big_fb (linear-64bpp-rotate-90)
[445.248712] Starting subtest: linear-64bpp-rotate-90
[445.310451] Subtest linear-64bpp-rotate-90: SKIP (0.061s)
[445.523289] [069/131] (580s left) gem_exec_whisper (basic-fds-forked-all)
[445.613553] Starting subtest: basic-fds-forked-all
[468.434415] Subtest basic-fds-forked-all: SUCCESS (22.819s)
[468.726709] [070/131] (557s left) syncobj_wait (invalid-signal-zero-handles)
[468.802256] Starting subtest: invalid-signal-zero-handles
[468.803173] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[468.985890] [071/131] (557s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[469.171407] Starting subtest: primary-x-tiled-reflect-x-180
[479.377921] Subtest primary-x-tiled-reflect-x-180: SUCCESS (10.207s)
[479.768686] [072/131] (546s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[479.952236] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[479.952964] Starting dynamic subtest: pipe-A
[480.036069] Dynamic subtest pipe-A: SUCCESS (0.084s)
[480.051664] Starting dynamic subtest: pipe-B
[480.248618] Dynamic subtest pipe-B: SUCCESS (0.211s)
[480.262558] Starting dynamic subtest: pipe-C
[480.444908] Dynamic subtest pipe-C: SUCCESS (0.195s)
[480.467468] Starting dynamic subtest: pipe-D
[480.658820] Dynamic subtest pipe-D: SUCCESS (0.212s)
[480.659927] Subtest planes-downscale-factor-0-5-upscale-20x20: SUCCESS (0.708s)
[481.027693] [073/131] (545s left) syncobj_basic (illegal-fd-to-handle)
[481.103549] Starting subtest: illegal-fd-to-handle
[481.104410] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[481.304082] [074/131] (545s left) i915_drm_fdinfo (isolation)
[481.371969] Starting subtest: isolation
[481.372964] Starting dynamic subtest: rcs0
[481.400245] Dynamic subtest rcs0: SKIP (0.027s)
[481.411516] Starting dynamic subtest: bcs0
[481.413940] Dynamic subtest bcs0: SKIP (0.000s)
[481.424934] Starting dynamic subtest: vcs0
[481.427434] Dynamic subtest vcs0: SKIP (0.000s)
[481.438170] Starting dynamic subtest: vcs1
[481.440372] Dynamic subtest vcs1: SKIP (0.000s)
[481.451108] Starting dynamic subtest: vecs0
[481.453572] Dynamic subtest vecs0: SKIP (0.000s)
[481.464071] Starting dynamic subtest: vecs1
[481.465940] Dynamic subtest vecs1: SKIP (0.000s)
[481.476523] Starting dynamic subtest: ccs0
[481.478614] Dynamic subtest ccs0: SKIP (0.000s)
[481.480874] Subtest isolation: SKIP (0.036s)
[481.537769] [075/131] (544s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[483.055629] Starting subtest: modeset-non-lpsp-stress-no-wait
[484.900604] Subtest modeset-non-lpsp-stress-no-wait: SUCCESS (1.848s)
[485.115345] [076/131] (541s left) kms_psr (pr-cursor-plane-move)
[485.303289] Subtest pr-cursor-plane-move: SKIP (0.000s)
[485.359099] [077/131] (541s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[485.549028] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[485.550549] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[485.763934] [078/131] (540s left) kms_psr (fbc-pr-cursor-render)
[485.950350] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[486.008029] [079/131] (540s left) gem_exec_reloc (basic-cpu-read-noreloc)
[486.091378] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[486.159636] [080/131] (540s left) i915_drm_fdinfo (virtual-idle)
[486.226550] Starting subtest: virtual-idle
[489.841288] Subtest virtual-idle: SUCCESS (3.613s)
[489.979991] [081/131] (536s left) i915_pm_rpm (gem-pread)
[492.091481] Starting subtest: gem-pread
[492.866538] Subtest gem-pread: SUCCESS (0.775s)
[493.158351] [082/131] (533s left) gem_linear_blits (interruptible)
[493.584437] Starting subtest: interruptible
[500.830358] Subtest interruptible: SUCCESS (7.250s)
[501.044938] [083/131] (525s left) kms_atomic_transition (modeset-transition)
[501.279286] Starting subtest: modeset-transition
[501.280186] Starting dynamic subtest: 1x-outputs
[503.900525] Dynamic subtest 1x-outputs: SUCCESS (2.620s)
[503.902188] Subtest modeset-transition: SUCCESS (2.623s)
[504.224277] [084/131] (522s left) kms_cursor_crc (cursor-suspend)
[504.484193] Starting subtest: cursor-suspend
[504.486428] Starting dynamic subtest: pipe-A-DP-3
[544.223513] Dynamic subtest pipe-A-DP-3: SUCCESS (8.421s)
[544.252687] Starting dynamic subtest: pipe-D-DP-3
[583.389892] Dynamic subtest pipe-D-DP-3: SUCCESS (7.705s)
[583.390936] Subtest cursor-suspend: SUCCESS (16.134s)
[583.963793] [085/131] (443s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[584.175486] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[584.177200] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[584.382956] [086/131] (442s left) kms_frontbuffer_tracking (fbc-2p-rte)
[584.575513] Starting subtest: fbc-2p-rte
[584.577291] Subtest fbc-2p-rte: SKIP (0.000s)
[584.785036] [087/131] (442s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[587.389752] Starting subtest: verify-pxp-execution-after-suspend-resume
[587.391752] Subtest verify-pxp-execution-after-suspend-resume: SKIP (0.000s)
[587.532436] [088/131] (439s left) gem_exec_balancer (parallel-ordering)
[587.920993] Starting subtest: parallel-ordering
[589.575067] Subtest parallel-ordering: SUCCESS (1.654s)
[589.782768] [089/131] (437s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[589.977608] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[589.979354] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[590.166846] [090/131] (437s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[590.366976] Starting subtest: x-tiled-64bpp-rotate-270
[590.433688] Subtest x-tiled-64bpp-rotate-270: SKIP (0.066s)
[590.648800] [091/131] (436s left) tools_test (sysfs_l3_parity)
[590.699439] Starting subtest: sysfs_l3_parity
[590.767222] Subtest sysfs_l3_parity: SKIP (0.072s)
[590.933958] [092/131] (436s left) perf (blocking)
[591.228073] Starting subtest: blocking
[591.228998] Starting dynamic subtest: 0-rcs0
[601.251356] Dynamic subtest 0-rcs0: SUCCESS (10.023s)
[601.252304] Subtest blocking: SUCCESS (10.025s)
[601.315701] [093/131] (426s left) gem_exec_suspend (basic)
[601.412144] Starting subtest: basic
[601.413117] Starting dynamic subtest: smem
[602.636872] Dynamic subtest smem: SUCCESS (1.224s)
[602.652279] Starting dynamic subtest: lmem0
[603.821685] Dynamic subtest lmem0: SUCCESS (1.184s)
[603.822674] Subtest basic: SUCCESS (2.410s)
[604.143151] [094/131] (423s left) gem_mmap_offset (partial-mmap)
[604.218034] Starting subtest: partial-mmap
[604.218933] Starting dynamic subtest: lmem0
[604.222448] Dynamic subtest lmem0: SUCCESS (0.005s)
[604.238163] Starting dynamic subtest: smem0
[604.239318] Dynamic subtest smem0: SUCCESS (0.004s)
[604.240519] Subtest partial-mmap: SUCCESS (0.011s)
[604.412075] [095/131] (423s left) kms_hdr (bpc-switch-suspend)
[604.599781] Starting subtest: bpc-switch-suspend
[607.870187] Starting dynamic subtest: pipe-A-DP-3
[627.580591] Dynamic subtest pipe-A-DP-3: SUCCESS (4.884s)
[627.581540] Subtest bpc-switch-suspend: SUCCESS (8.156s)
[627.911159] [096/131] (399s left) gem_mmap (bad-object)
[627.993462] Subtest bad-object: SKIP (0.000s)
[628.073017] [097/131] (399s left) syncobj_timeline (invalid-transfer-bad-pad)
[628.154687] Starting subtest: invalid-transfer-bad-pad
[628.155578] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[628.310206] [098/131] (399s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[628.501250] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[628.502965] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[628.698065] [099/131] (399s left) sysfs_heartbeat_interval (precise)
[628.780077] Starting subtest: precise
[628.781055] Starting dynamic subtest: vecs0
[630.432414] Dynamic subtest vecs0: SUCCESS (1.651s)
[630.447170] Starting dynamic subtest: ccs0
[631.979389] Dynamic subtest ccs0: SUCCESS (1.546s)
[631.994898] Starting dynamic subtest: vcs0
[633.422374] Dynamic subtest vcs0: SUCCESS (1.442s)
[633.436946] Starting dynamic subtest: bcs0
[636.749234] Dynamic subtest bcs0: SUCCESS (3.326s)
[636.763636] Starting dynamic subtest: vecs1
[638.230315] Dynamic subtest vecs1: SUCCESS (1.480s)
[638.244758] Starting dynamic subtest: rcs0
[639.708362] Dynamic subtest rcs0: SUCCESS (1.477s)
[639.723214] Starting dynamic subtest: vcs1
[642.750262] Dynamic subtest vcs1: SUCCESS (3.041s)
[642.751254] Subtest precise: SUCCESS (13.970s)
[642.983273] [100/131] (385s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[643.168013] Starting subtest: basic-flip-after-cursor-varying-size
[644.201124] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.032s)
[644.549975] [101/131] (383s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[644.741083] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[647.548261] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (2.808s)
[647.733696] [102/131] (380s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[647.820652] Starting subtest: y-tiled-ccs-to-y-tiled
[647.822620] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[648.114250] [103/131] (380s left) gem_vm_create (isolation)
[648.197664] Starting subtest: isolation
[648.210208] Subtest isolation: SUCCESS (0.012s)
[648.452229] [104/131] (380s left) syncobj_wait (invalid-wait-bad-flags)
[648.529379] Starting subtest: invalid-wait-bad-flags
[648.530332] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[648.690834] [105/131] (379s left) gem_ctx_shared (q-promotion)
[648.784390] Starting subtest: Q-promotion
[648.785289] Starting dynamic subtest: rcs0
[649.068401] Dynamic subtest rcs0: SUCCESS (0.284s)
[649.083365] Starting dynamic subtest: bcs0
[649.260872] Dynamic subtest bcs0: SUCCESS (0.191s)
[649.275905] Starting dynamic subtest: vcs0
[649.455467] Dynamic subtest vcs0: SUCCESS (0.193s)
[649.469902] Starting dynamic subtest: vcs1
[649.650051] Dynamic subtest vcs1: SUCCESS (0.193s)
[649.664420] Starting dynamic subtest: vecs0
[649.841343] Dynamic subtest vecs0: SUCCESS (0.190s)
[649.855449] Starting dynamic subtest: vecs1
[650.033750] Dynamic subtest vecs1: SUCCESS (0.191s)
[650.048329] Starting dynamic subtest: ccs0
[650.228746] Dynamic subtest ccs0: SUCCESS (0.194s)
[650.229583] Subtest Q-promotion: SUCCESS (1.446s)
[650.612743] [106/131] (378s left) syncobj_timeline (single-wait-available-signaled)
[650.690391] Starting subtest: single-wait-available-signaled
[650.691310] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[650.897563] [107/131] (377s left) drm_buddy (drm_buddy)
[650.948685] Starting subtest: drm_buddy
[650.956394] Starting dynamic subtest: drm_test_buddy_alloc_limit
[651.042506] Dynamic subtest drm_test_buddy_alloc_limit: SUCCESS (0.083s)
[651.089854] Starting dynamic subtest: drm_test_buddy_alloc_optimistic
[651.129896] Dynamic subtest drm_test_buddy_alloc_optimistic: SUCCESS (0.085s)
[651.161580] Starting dynamic subtest: drm_test_buddy_alloc_pessimistic
[651.220941] Dynamic subtest drm_test_buddy_alloc_pessimistic: SUCCESS (0.089s)
[651.269767] Starting dynamic subtest: drm_test_buddy_alloc_pathological
[651.304550] Dynamic subtest drm_test_buddy_alloc_pathological: SUCCESS (0.079s)
[651.326019] Starting dynamic subtest: drm_test_buddy_alloc_contiguous
[651.389272] Dynamic subtest drm_test_buddy_alloc_contiguous: SUCCESS (0.080s)
[651.435478] Starting dynamic subtest: drm_test_buddy_alloc_clear
[651.516353] Dynamic subtest drm_test_buddy_alloc_clear: SUCCESS (0.125s)
[651.530738] Starting dynamic subtest: drm_test_buddy_alloc_range_bias
[651.597770] Dynamic subtest drm_test_buddy_alloc_range_bias: SUCCESS (0.081s)
[651.645198] Starting dynamic subtest: drm_test_buddy_fragmentation_performance
[657.816011] Dynamic subtest drm_test_buddy_fragmentation_performance: SUCCESS (6.214s)
[657.816960] Subtest drm_buddy: SUCCESS (6.866s)
[657.984313] [108/131] (370s left) gem_workarounds (reset-context)
[658.078102] Starting subtest: reset-context
[658.305163] Subtest reset-context: SUCCESS (0.227s)
[658.497196] [109/131] (370s left) gem_exec_reloc (basic-wc-gtt-active)
[658.581346] Subtest basic-wc-gtt-active: SKIP (0.000s)
[658.660291] [110/131] (370s left) kms_vblank (wait-busy)
[658.845040] Starting subtest: wait-busy
[658.847331] Starting dynamic subtest: pipe-A-DP-3
[661.341710] Dynamic subtest pipe-A-DP-3: SUCCESS (2.495s)
[661.373477] Starting dynamic subtest: pipe-D-DP-3
[663.779093] Dynamic subtest pipe-D-DP-3: SUCCESS (2.430s)
[663.779940] Subtest wait-busy: SUCCESS (4.934s)
[664.071460] [111/131] (364s left) gen9_exec_parse (bb-oversize)
[664.162214] Subtest bb-oversize: SKIP (0.000s)
[664.224697] [112/131] (364s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[664.303475] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[664.304427] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[664.507130] [113/131] (364s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[664.695990] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[664.697635] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[664.893349] [114/131] (364s left) prime_vgem (coherency-gtt)
[664.995070] Starting subtest: coherency-gtt
[664.997070] Subtest coherency-gtt: SKIP (0.000s)
[665.212713] [115/131] (364s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[665.488440] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[665.643137] [116/131] (363s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[665.839460] Starting subtest: y-tiled-64bpp-rotate-270
[665.841359] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[666.052229] [117/131] (363s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[666.243036] Starting subtest: psr-rgb101010-draw-mmap-cpu
[666.244800] Subtest psr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[666.449578] [118/131] (363s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[666.530735] Starting subtest: y-tiled-to-vebox-y-tiled
[666.532766] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[666.784499] [119/131] (362s left) perf_pmu (semaphore-busy)
[666.854628] Starting subtest: semaphore-busy
[666.855537] Starting dynamic subtest: rcs0
[668.500182] Dynamic subtest rcs0: SUCCESS (1.643s)
[668.516695] Starting dynamic subtest: bcs0
[670.138910] Dynamic subtest bcs0: SUCCESS (1.634s)
[670.157482] Starting dynamic subtest: vcs0
[671.782218] Dynamic subtest vcs0: SUCCESS (1.639s)
[671.798819] Starting dynamic subtest: vcs1
[673.419972] Dynamic subtest vcs1: SUCCESS (1.633s)
[673.436792] Starting dynamic subtest: vecs0
[675.060186] Dynamic subtest vecs0: SUCCESS (1.636s)
[675.076675] Starting dynamic subtest: vecs1
[676.699598] Dynamic subtest vecs1: SUCCESS (1.635s)
[676.715893] Starting dynamic subtest: ccs0
[678.337751] Dynamic subtest ccs0: SUCCESS (1.634s)
[678.339479] Subtest semaphore-busy: SUCCESS (11.483s)
[678.564169] [120/131] (351s left) kms_flip (2x-flip-vs-fences)
[678.750280] Starting subtest: 2x-flip-vs-fences
[678.752084] Subtest 2x-flip-vs-fences: SKIP (0.000s)
[678.962794] [121/131] (350s left) gem_exec_schedule (deep)
[679.201542] Starting subtest: deep
[679.202456] Starting dynamic subtest: rcs0
[694.355888] Dynamic subtest rcs0: SUCCESS (15.156s)
[694.370385] Starting dynamic subtest: bcs0
[709.893595] Dynamic subtest bcs0: SUCCESS (15.536s)
[709.908271] Starting dynamic subtest: vcs0
[725.135115] Dynamic subtest vcs0: SUCCESS (15.240s)
[725.149729] Starting dynamic subtest: vcs1
[740.770743] Dynamic subtest vcs1: SUCCESS (15.634s)
[740.786816] Starting dynamic subtest: vecs0
[756.948855] Dynamic subtest vecs0: SUCCESS (16.176s)
[756.963224] Starting dynamic subtest: vecs1
[772.333698] Dynamic subtest vecs1: SUCCESS (15.383s)
[772.348407] Starting dynamic subtest: ccs0
[787.700862] Dynamic subtest ccs0: SUCCESS (15.366s)
[787.701774] Subtest deep: SUCCESS (108.502s)
[788.799093] [122/131] (241s left) gem_create (hog-create)
[788.881643] Starting subtest: hog-create
[788.882573] Starting dynamic subtest: lmem0
[821.198573] Dynamic subtest lmem0: SUCCESS (32.316s)
[821.217465] Starting dynamic subtest: smem0
[853.451456] Dynamic subtest smem0: SUCCESS (32.251s)
[853.452456] Subtest hog-create: SUCCESS (64.570s)
[853.740209] [123/131] (176s left) api_intel_bb (object-reloc-purge-cache)
[853.828661] Starting subtest: object-reloc-purge-cache
[853.831876] Subtest object-reloc-purge-cache: SKIP (0.002s)
[854.036695] [124/131] (175s left) kms_lease (lease-unleased-crtc)
[854.221482] Starting subtest: lease-unleased-crtc
[854.222402] Starting dynamic subtest: pipe-A-DP-3
[854.347003] Dynamic subtest pipe-A-DP-3: SUCCESS (0.125s)
[854.362920] Starting dynamic subtest: pipe-B-DP-3
[854.402834] Dynamic subtest pipe-B-DP-3: SUCCESS (0.053s)
[854.417962] Starting dynamic subtest: pipe-C-DP-3
[854.455952] Dynamic subtest pipe-C-DP-3: SUCCESS (0.053s)
[854.471789] Starting dynamic subtest: pipe-D-DP-3
[854.513507] Dynamic subtest pipe-D-DP-3: SUCCESS (0.054s)
[854.514391] Subtest lease-unleased-crtc: SUCCESS (0.292s)
[854.750761] [125/131] (175s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[854.950075] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[855.643579] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.693s)
[855.942361] [126/131] (174s left) kms_chamelium_frames (dp-crc-multiple)
[856.204452] Subtest dp-crc-multiple: SKIP (0.000s)
[856.356320] [127/131] (173s left) gem_partial_pwrite_pread (write)
[856.439498] Subtest write: SKIP (0.000s)
[856.529009] [128/131] (173s left) kms_psr (psr-primary-page-flip)
[856.717562] Subtest psr-primary-page-flip: SKIP (0.000s)
[856.775941] [129/131] (173s left) gem_exec_whisper (basic-queues-forked)
[856.867671] Starting subtest: basic-queues-forked
[879.276301] Subtest basic-queues-forked: SUCCESS (22.406s)
[879.554985] [130/131] (150s left) prime_vgem (sync)
[879.651025] Starting subtest: sync
[879.652271] Starting dynamic subtest: rcs0
[879.722371] Dynamic subtest rcs0: SUCCESS (0.071s)
[879.738606] Starting dynamic subtest: bcs0
[879.781875] Dynamic subtest bcs0: SUCCESS (0.058s)
[879.800886] Starting dynamic subtest: vcs0
[879.824164] Dynamic subtest vcs0: SUCCESS (0.041s)
[879.844663] Starting dynamic subtest: vcs1
[879.865690] Dynamic subtest vcs1: SUCCESS (0.040s)
[879.886398] Starting dynamic subtest: vecs0
[879.905737] Dynamic subtest vecs0: SUCCESS (0.039s)
[879.926660] Starting dynamic subtest: vecs1
[879.946877] Dynamic subtest vecs1: SUCCESS (0.040s)
[879.967588] Starting dynamic subtest: ccs0
[879.989323] Dynamic subtest ccs0: SUCCESS (0.041s)
[879.990280] Subtest sync: SUCCESS (0.339s)
[880.207701] [131/131] (150s left) kms_properties (crtc-properties-legacy)
[880.396374] Starting subtest: crtc-properties-legacy
[880.397275] Starting dynamic subtest: pipe-A-DP-3
[880.722694] Dynamic subtest pipe-A-DP-3: SUCCESS (0.325s)
[880.740989] Starting dynamic subtest: pipe-B-DP-3
[881.075818] Dynamic subtest pipe-B-DP-3: SUCCESS (0.350s)
[881.090033] Starting dynamic subtest: pipe-C-DP-3
[881.410224] Dynamic subtest pipe-C-DP-3: SUCCESS (0.333s)
[881.427338] Starting dynamic subtest: pipe-D-DP-3
[881.764052] Dynamic subtest pipe-D-DP-3: SUCCESS (0.351s)
[881.765022] Subtest crtc-properties-legacy: SUCCESS (1.368s)
[882.084298] Closing watchdogs
results: parsing output: 0/ for test: kms_pm_rpm
results: parsing output: 1/ for test: gem_exec_async
results: parsing output: 2/ for test: kms_cursor_crc
results: parsing output: 3/ for test: perf_pmu
results: parsing output: 4/ for test: kms_atomic_transition
results: parsing output: 5/ for test: gem_ctx_persistence
results: parsing output: 6/ for test: kms_ccs
results: parsing output: 7/ for test: kms_content_protection
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_display_modes
results: parsing output: 10/ for test: gem_exec_schedule
results: parsing output: 11/ for test: kms_flip_event_leak
results: parsing output: 12/ for test: gem_ccs
results: parsing output: 13/ for test: kms_getfb
results: parsing output: 14/ for test: gem_exec_fence
results: parsing output: 15/ for test: kms_psr
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: syncobj_wait
results: parsing output: 18/ for test: kms_ccs
results: parsing output: 19/ for test: gem_eio
results: parsing output: 20/ for test: perf_pmu
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: kms_flip_scaled_crc
results: parsing output: 23/ for test: kms_cursor_legacy
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: syncobj_basic
results: parsing output: 26/ for test: kms_content_protection
results: parsing output: 27/ for test: kms_properties
results: parsing output: 28/ for test: gem_request_retire
results: parsing output: 29/ for test: kms_rotation_crc
results: parsing output: 30/ for test: kms_ccs
results: parsing output: 31/ for test: gem_mmap_gtt
results: parsing output: 32/ for test: gem_shrink
results: parsing output: 33/ for test: syncobj_timeline
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: kms_dsc
results: parsing output: 36/ for test: kms_cursor_legacy
results: parsing output: 37/ for test: prime_vgem
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_plane_scaling
results: parsing output: 40/ for test: gem_mmap
results: parsing output: 41/ for test: kms_plane_multiple
results: parsing output: 42/ for test: kms_big_fb
results: parsing output: 43/ for test: kms_async_flips
results: parsing output: 44/ for test: perf
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: gem_exec_schedule
results: parsing output: 47/ for test: gem_create
results: parsing output: 48/ for test: gem_spin_batch
results: parsing output: 49/ for test: kms_addfb_basic
results: parsing output: 50/ for test: syncobj_timeline
results: parsing output: 51/ for test: gem_mmap_gtt
results: parsing output: 52/ for test: kms_sequence
results: parsing output: 53/ for test: kms_psr
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: gem_ctx_bad_destroy
results: parsing output: 56/ for test: gem_ctx_persistence
results: parsing output: 57/ for test: kms_flip
results: parsing output: 58/ for test: kms_ccs
results: parsing output: 59/ for test: kms_plane_alpha_blend
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_psr2_sf
results: parsing output: 62/ for test: kms_prop_blob
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_ccs
results: parsing output: 65/ for test: i915_query
results: parsing output: 66/ for test: kms_atomic_interruptible
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: gem_exec_whisper
results: parsing output: 69/ for test: syncobj_wait
results: parsing output: 70/ for test: kms_rotation_crc
results: parsing output: 71/ for test: kms_plane_scaling
results: parsing output: 72/ for test: syncobj_basic
results: parsing output: 73/ for test: i915_drm_fdinfo
results: parsing output: 74/ for test: kms_pm_rpm
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_psr
results: parsing output: 78/ for test: gem_exec_reloc
results: parsing output: 79/ for test: i915_drm_fdinfo
results: parsing output: 80/ for test: i915_pm_rpm
results: parsing output: 81/ for test: gem_linear_blits
results: parsing output: 82/ for test: kms_atomic_transition
results: parsing output: 83/ for test: kms_cursor_crc
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: gem_pxp
results: parsing output: 87/ for test: gem_exec_balancer
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_big_fb
results: parsing output: 90/ for test: tools_test
results: parsing output: 91/ for test: perf
results: parsing output: 92/ for test: gem_exec_suspend
results: parsing output: 93/ for test: gem_mmap_offset
results: parsing output: 94/ for test: kms_hdr
results: parsing output: 95/ for test: gem_mmap
results: parsing output: 96/ for test: syncobj_timeline
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: sysfs_heartbeat_interval
results: parsing output: 99/ for test: kms_cursor_legacy
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: gem_render_copy
results: parsing output: 102/ for test: gem_vm_create
results: parsing output: 103/ for test: syncobj_wait
results: parsing output: 104/ for test: gem_ctx_shared
results: parsing output: 105/ for test: syncobj_timeline
results: parsing output: 106/ for test: drm_buddy
results: parsing output: 107/ for test: gem_workarounds
results: parsing output: 108/ for test: gem_exec_reloc
results: parsing output: 109/ for test: kms_vblank
results: parsing output: 110/ for test: gen9_exec_parse
results: parsing output: 111/ for test: syncobj_wait
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: prime_vgem
results: parsing output: 114/ for test: kms_chamelium_hpd
results: parsing output: 115/ for test: kms_big_fb
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: gem_render_copy
results: parsing output: 118/ for test: perf_pmu
results: parsing output: 119/ for test: kms_flip
results: parsing output: 120/ for test: gem_exec_schedule
results: parsing output: 121/ for test: gem_create
results: parsing output: 122/ for test: api_intel_bb
results: parsing output: 123/ for test: kms_lease
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: kms_chamelium_frames
results: parsing output: 126/ for test: gem_partial_pwrite_pread
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: gem_exec_whisper
results: parsing output: 129/ for test: prime_vgem
results: parsing output: 130/ for test: kms_properties
Done.