[63.798298] Initializing watchdogs
[63.798366]   /dev/watchdog0
[63.818746] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[63.829866] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[63.833765] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[63.836406] [001/133] (960s left) kms_flip (flip-vs-dpms-on-nop)
[65.378947] Starting subtest: flip-vs-dpms-on-nop
[65.383775] Starting dynamic subtest: A-HDMI-A3
[66.467600] Dynamic subtest A-HDMI-A3: SUCCESS (1.084s)
[66.477541] Starting dynamic subtest: B-HDMI-A3
[67.438104] Dynamic subtest B-HDMI-A3: SUCCESS (0.970s)
[67.445930] Starting dynamic subtest: C-HDMI-A3
[68.442498] Dynamic subtest C-HDMI-A3: SUCCESS (1.004s)
[68.450213] Starting dynamic subtest: D-HDMI-A3
[69.415638] Dynamic subtest D-HDMI-A3: SUCCESS (0.973s)
[69.416570] Subtest flip-vs-dpms-on-nop: SUCCESS (4.038s)
[69.641984] [002/133] (954s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier)
[71.151421] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier
[71.153277] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier: SKIP (0.000s)
[71.235189] [003/133] (953s left) kms_psr (psr2-cursor-mmap-cpu)
[72.753377] Subtest psr2-cursor-mmap-cpu: SKIP (0.000s)
[72.812993] [004/133] (951s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[74.323116] Starting subtest: psr-rgb565-draw-mmap-cpu
[74.324861] Subtest psr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[74.458303] [005/133] (950s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[75.992405] Starting subtest: fb-8bpc-vs-panel-6bpc
[75.994975] Subtest fb-8bpc-vs-panel-6bpc: SKIP (0.000s)
[76.092251] [006/133] (948s left) gem_spin_batch (resubmit)
[76.200751] Starting subtest: resubmit
[76.201654] Starting dynamic subtest: rcs0
[76.233722] Dynamic subtest rcs0: SUCCESS (0.033s)
[76.241396] Starting dynamic subtest: bcs0
[76.242268] Dynamic subtest bcs0: SUCCESS (0.003s)
[76.249890] Starting dynamic subtest: vcs0
[76.250809] Dynamic subtest vcs0: SUCCESS (0.004s)
[76.258611] Starting dynamic subtest: vcs1
[76.259593] Dynamic subtest vcs1: SUCCESS (0.002s)
[76.266942] Starting dynamic subtest: vecs0
[76.268192] Dynamic subtest vecs0: SUCCESS (0.002s)
[76.275245] Starting dynamic subtest: vecs1
[76.276296] Dynamic subtest vecs1: SUCCESS (0.002s)
[76.283455] Starting dynamic subtest: ccs0
[76.284383] Dynamic subtest ccs0: SUCCESS (0.002s)
[76.285258] Subtest resubmit: SUCCESS (0.050s)
[76.524062] [007/133] (948s left) kms_vblank (accuracy-idle)
[78.029996] Starting subtest: accuracy-idle
[78.032143] Starting dynamic subtest: pipe-A-HDMI-A-3
[80.366956] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.335s)
[80.377539] Starting dynamic subtest: pipe-D-HDMI-A-3
[82.559117] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.188s)
[82.560136] Subtest accuracy-idle: SUCCESS (4.528s)
[82.721492] [008/133] (942s left) syncobj_timeline (etime-single-wait-submitted)
[82.792167] Starting subtest: etime-single-wait-submitted
[82.897664] Subtest etime-single-wait-submitted: SUCCESS (0.105s)
[83.034707] [009/133] (941s left) kms_content_protection (dp-mst-lic-type-1)
[84.608538] Starting subtest: dp-mst-lic-type-1
[84.610270] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[84.803635] [010/133] (940s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[86.321462] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[87.596373] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.274s)
[87.766862] [011/133] (937s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[89.277233] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[89.283223] Starting dynamic subtest: A-HDMI-A3
[90.034241] Dynamic subtest A-HDMI-A3: SUCCESS (0.751s)
[90.041932] Starting dynamic subtest: B-HDMI-A3
[90.722930] Dynamic subtest B-HDMI-A3: SUCCESS (0.688s)
[90.730606] Starting dynamic subtest: C-HDMI-A3
[91.404180] Dynamic subtest C-HDMI-A3: SUCCESS (0.682s)
[91.411789] Starting dynamic subtest: D-HDMI-A3
[92.071561] Dynamic subtest D-HDMI-A3: SUCCESS (0.666s)
[92.072441] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (2.793s)
[92.253978] [012/133] (932s left) gem_ccs (large-ctrl-surf-copy)
[92.335486] Starting subtest: large-ctrl-surf-copy
[92.975350] Subtest large-ctrl-surf-copy: SUCCESS (0.639s)
[93.153630] [013/133] (931s left) syncobj_timeline (signal-point-0)
[93.223267] Starting subtest: signal-point-0
[93.224364] Subtest signal-point-0: SUCCESS (0.000s)
[93.385921] [014/133] (931s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[94.895972] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[94.897709] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[95.108253] [015/133] (930s left) gem_render_copy (yf-tiled-to-vebox-linear)
[95.193532] Starting subtest: yf-tiled-to-vebox-linear
[95.195739] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[95.400729] [016/133] (929s left) kms_cursor_crc (cursor-offscreen-64x64)
[97.053569] Starting subtest: cursor-offscreen-64x64
[97.057880] Starting dynamic subtest: pipe-A-HDMI-A-3
[99.556955] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.498s)
[99.592270] Starting dynamic subtest: pipe-D-HDMI-A-3
[101.976288] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.392s)
[101.977323] Subtest cursor-offscreen-64x64: SUCCESS (4.923s)
[102.360721] [017/133] (923s left) gem_exec_reloc (basic-wc-gtt)
[102.443016] Subtest basic-wc-gtt: SKIP (0.000s)
[102.522490] [018/133] (922s left) i915_suspend (fence-restore-untiled)
[102.602169] Starting subtest: fence-restore-untiled
[102.603973] Subtest fence-restore-untiled: SKIP (0.000s)
[102.733784] [019/133] (922s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[104.245411] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[104.247169] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[104.370370] [020/133] (921s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[105.907206] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[105.908985] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[106.043462] [021/133] (919s left) kms_getfb (getfb2-handle-protection)
[107.588186] Starting subtest: getfb2-handle-protection
[107.604286] Subtest getfb2-handle-protection: SUCCESS (0.017s)
[107.769586] [022/133] (917s left) gem_exec_balancer (parallel-balancer)
[108.159265] Starting subtest: parallel-balancer
[109.755735] Subtest parallel-balancer: SUCCESS (1.596s)
[109.870608] [023/133] (915s left) kms_plane_lowres (tiling-yf)
[111.375517] Starting subtest: tiling-yf
[111.377216] Subtest tiling-yf: SKIP (0.000s)
[111.478611] [024/133] (914s left) gen9_exec_parse (valid-registers)
[111.576402] Subtest valid-registers: SKIP (0.000s)
[111.647900] [025/133] (914s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[113.153529] Starting subtest: sprite-rotation-90-pos-100-0
[113.155266] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[113.235837] [026/133] (912s left) kms_getfb (getfb-handle-closed)
[114.751353] Starting subtest: getfb-handle-closed
[114.752278] Subtest getfb-handle-closed: SUCCESS (0.000s)
[114.884733] [027/133] (911s left) kms_explicit_fence (multiplane-atomic-fence-wait)
[116.481076] Starting subtest: multiplane-atomic-fence-wait
[116.792874] Subtest multiplane-atomic-fence-wait: SUCCESS (0.312s)
[117.081728] [028/133] (908s left) syncobj_timeline (wait-for-submit-complex)
[117.159325] Starting subtest: wait-for-submit-complex
[117.221997] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[117.320897] [029/133] (908s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[118.827554] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[118.888679] [030/133] (907s left) gem_ccs (ctrl-surf-copy)
[118.967967] Starting subtest: ctrl-surf-copy
[118.968935] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0
[119.023758] Dynamic subtest linear-compressed-compfmt0-smem-lmem0: SUCCESS (0.055s)
[119.031762] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0
[119.218747] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.194s)
[119.226487] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0
[119.244805] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0: SUCCESS (0.025s)
[119.252545] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0
[119.444375] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.199s)
[119.452126] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0
[119.470358] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0: SUCCESS (0.025s)
[119.478135] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0
[119.667528] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.196s)
[119.675221] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0
[119.694469] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0: SUCCESS (0.026s)
[119.702273] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0
[119.886301] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.191s)
[119.887258] Subtest ctrl-surf-copy: SUCCESS (0.918s)
[120.048650] [031/133] (906s left) i915_pm_rps (reset)
[120.131977] Starting subtest: reset
[125.941170] Subtest reset: SUCCESS (5.806s)
[126.076024] [032/133] (900s left) kms_addfb_basic (bad-pitch-0)
[126.150139] Starting subtest: bad-pitch-0
[126.150978] Subtest bad-pitch-0: SUCCESS (0.000s)
[127.715177] [033/133] (898s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[129.254946] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[129.256780] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[129.376810] [034/133] (896s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[130.906471] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[130.907403] Starting dynamic subtest: pipe-A
[131.498752] Dynamic subtest pipe-A: SUCCESS (0.593s)
[131.509027] Starting dynamic subtest: pipe-B
[132.058035] Dynamic subtest pipe-B: SUCCESS (0.558s)
[132.068172] Starting dynamic subtest: pipe-C
[132.618166] Dynamic subtest pipe-C: SUCCESS (0.559s)
[132.634171] Starting dynamic subtest: pipe-D
[133.193980] Dynamic subtest pipe-D: SUCCESS (0.575s)
[133.195166] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (2.289s)
[133.406747] [035/133] (893s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[134.911543] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[134.912445] Starting dynamic subtest: pipe-A-HDMI-A-3
[134.921166] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[134.929494] Starting dynamic subtest: pipe-B-HDMI-A-3
[134.938049] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[134.946306] Starting dynamic subtest: pipe-C-HDMI-A-3
[134.954925] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[134.962975] Starting dynamic subtest: pipe-D-HDMI-A-3
[134.972436] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[134.974188] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SKIP (0.006s)
[135.172193] [036/133] (891s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[136.678669] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[136.680399] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[136.877549] [037/133] (889s left) perf (enable-disable)
[137.284135] Starting subtest: enable-disable
[137.284999] Starting dynamic subtest: 0-rcs0
[139.517553] Dynamic subtest 0-rcs0: SUCCESS (2.234s)
[139.518458] Subtest enable-disable: SUCCESS (2.235s)
[139.571816] [038/133] (887s left) kms_flip (2x-wf_vblank-ts-check)
[141.080403] Starting subtest: 2x-wf_vblank-ts-check
[141.093458] Subtest 2x-wf_vblank-ts-check: SKIP (0.013s)
[141.200505] [039/133] (885s left) gem_exec_endless (dispatch)
[141.313154] Starting subtest: dispatch
[141.314143] Starting dynamic subtest: rcs0
[141.322567] Dynamic subtest rcs0: SUCCESS (0.009s)
[141.332219] Starting dynamic subtest: bcs0
[141.334008] Dynamic subtest bcs0: SUCCESS (0.006s)
[141.342533] Starting dynamic subtest: vcs0
[141.344341] Dynamic subtest vcs0: SUCCESS (0.006s)
[141.353475] Starting dynamic subtest: vcs1
[141.355243] Dynamic subtest vcs1: SUCCESS (0.006s)
[141.364398] Starting dynamic subtest: vecs0
[141.366188] Dynamic subtest vecs0: SUCCESS (0.007s)
[141.376687] Starting dynamic subtest: vecs1
[141.378441] Dynamic subtest vecs1: SUCCESS (0.007s)
[141.386875] Starting dynamic subtest: ccs0
[141.388515] Dynamic subtest ccs0: SUCCESS (0.009s)
[141.389353] Subtest dispatch: SUCCESS (0.055s)
[141.455316] [040/133] (885s left) gem_readwrite (read-write)
[141.529056] Subtest read-write: SKIP (0.000s)
[141.640940] [041/133] (885s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[143.149935] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[143.151540] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[143.282739] [042/133] (883s left) gem_busy (close-race)
[143.395223] Starting subtest: close-race
[165.573415] Subtest close-race: SUCCESS (22.177s)
[166.050763] [FACT gem_busy (close-race)] new: kernel.kmod_is_loaded.vgem: true
[166.054294] [043/133] (860s left) kms_color (ctm-green-to-red)
[167.607826] Starting subtest: ctm-green-to-red
[167.608750] Starting dynamic subtest: pipe-A-HDMI-A-3
[168.256212] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.649s)
[168.267842] Starting dynamic subtest: pipe-B-HDMI-A-3
[168.740743] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.483s)
[168.750254] Starting dynamic subtest: pipe-C-HDMI-A-3
[169.241235] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.500s)
[169.251075] Starting dynamic subtest: pipe-D-HDMI-A-3
[169.731538] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.489s)
[169.732423] Subtest ctm-green-to-red: SUCCESS (2.124s)
[169.922373] [044/133] (857s left) perf_pmu (busy-accuracy-2)
[169.997533] Starting subtest: busy-accuracy-2
[169.998436] Starting dynamic subtest: rcs0
[173.068353] Dynamic subtest rcs0: SUCCESS (3.069s)
[173.078750] Starting dynamic subtest: bcs0
[176.134051] Dynamic subtest bcs0: SUCCESS (3.065s)
[176.144600] Starting dynamic subtest: vcs0
[179.202135] Dynamic subtest vcs0: SUCCESS (3.067s)
[179.212760] Starting dynamic subtest: vcs1
[182.270497] Dynamic subtest vcs1: SUCCESS (3.068s)
[182.281085] Starting dynamic subtest: vecs0
[185.337513] Dynamic subtest vecs0: SUCCESS (3.066s)
[185.347910] Starting dynamic subtest: vecs1
[188.403382] Dynamic subtest vecs1: SUCCESS (3.065s)
[188.413930] Starting dynamic subtest: ccs0
[191.468311] Dynamic subtest ccs0: SUCCESS (3.064s)
[191.469260] Subtest busy-accuracy-2: SUCCESS (21.470s)
[191.631070] [045/133] (835s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[193.151902] Starting subtest: psr-1p-primscrn-cur-indfb-move
[193.153527] Subtest psr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[193.343185] [046/133] (833s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[194.866439] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (0.000s)
[194.927993] [047/133] (832s left) dumb_buffer (create-clear)
[195.012466] Starting subtest: create-clear
[231.026568] Subtest create-clear: SUCCESS (36.011s)
[231.175459] [048/133] (796s left) syncobj_basic (bad-handle-to-fd)
[231.253397] Starting subtest: bad-handle-to-fd
[231.254317] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[231.377325] [049/133] (795s left) gem_exec_schedule (submit-golden-slice)
[231.480208] Starting subtest: submit-golden-slice
[231.481163] Starting dynamic subtest: rcs0
[231.562112] Dynamic subtest rcs0: SUCCESS (0.082s)
[231.572365] Starting dynamic subtest: bcs0
[231.618169] Dynamic subtest bcs0: SUCCESS (0.055s)
[231.628565] Starting dynamic subtest: vcs0
[231.672694] Dynamic subtest vcs0: SUCCESS (0.054s)
[231.683067] Starting dynamic subtest: vcs1
[231.728571] Dynamic subtest vcs1: SUCCESS (0.055s)
[231.738922] Starting dynamic subtest: vecs0
[231.780175] Dynamic subtest vecs0: SUCCESS (0.051s)
[231.790763] Starting dynamic subtest: vecs1
[231.838157] Dynamic subtest vecs1: SUCCESS (0.057s)
[231.848430] Starting dynamic subtest: ccs0
[231.890361] Dynamic subtest ccs0: SUCCESS (0.051s)
[231.891458] Subtest submit-golden-slice: SUCCESS (0.411s)
[232.310326] [050/133] (795s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[233.825143] Starting subtest: cursorA-vs-flipB-atomic
[233.826987] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[233.992837] [051/133] (793s left) kms_psr (psr2-basic)
[235.534346] Subtest psr2-basic: SKIP (0.000s)
[235.597442] [052/133] (791s left) gem_exec_schedule (wide)
[235.821458] Starting subtest: wide
[235.822967] Starting dynamic subtest: rcs0
[248.422091] Dynamic subtest rcs0: SUCCESS (12.598s)
[248.457058] Starting dynamic subtest: bcs0
[261.314904] Dynamic subtest bcs0: SUCCESS (12.894s)
[261.325419] Starting dynamic subtest: vcs0
[275.122946] Dynamic subtest vcs0: SUCCESS (13.806s)
[275.134516] Starting dynamic subtest: vcs1
[288.523028] Dynamic subtest vcs1: SUCCESS (13.396s)
[288.548196] Starting dynamic subtest: vecs0
[301.764370] Dynamic subtest vecs0: SUCCESS (13.244s)
[301.774930] Starting dynamic subtest: vecs1
[315.145586] Dynamic subtest vecs1: SUCCESS (13.380s)
[315.159070] Starting dynamic subtest: ccs0
[328.700224] Dynamic subtest ccs0: SUCCESS (13.553s)
[328.701181] Subtest wide: SUCCESS (92.878s)
[330.378631] [053/133] (697s left) syncobj_wait (invalid-wait-illegal-handle)
[330.461242] Starting subtest: invalid-wait-illegal-handle
[330.462152] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[330.581445] [054/133] (697s left) api_intel_bb (render)
[330.659423] Starting subtest: render
[330.660414] Starting dynamic subtest: render-none-512
[330.706453] Dynamic subtest render-none-512: SUCCESS (0.047s)
[330.716811] Starting dynamic subtest: render-none-1024
[330.782483] Dynamic subtest render-none-1024: SUCCESS (0.075s)
[330.792935] Starting dynamic subtest: render-x-512
[330.801762] Dynamic subtest render-x-512: SUCCESS (0.018s)
[330.812167] Starting dynamic subtest: render-x-1024
[330.868167] Dynamic subtest render-x-1024: SUCCESS (0.065s)
[330.878574] Starting dynamic subtest: render-y-512
[330.887260] Dynamic subtest render-y-512: SUCCESS (0.018s)
[330.897796] Starting dynamic subtest: render-y-1024
[330.945465] Dynamic subtest render-y-1024: SUCCESS (0.057s)
[330.946434] Subtest render: SUCCESS (0.287s)
[331.060259] [055/133] (696s left) kms_psr (fbc-psr2-suspend)
[332.577244] Subtest fbc-psr2-suspend: SKIP (0.000s)
[332.633781] [056/133] (695s left) gem_eio (in-flight-10ms)
[332.935313] Starting subtest: in-flight-10ms
[338.011788] Subtest in-flight-10ms: SUCCESS (5.077s)
[339.615077] [057/133] (688s left) kms_psr (fbc-psr2-cursor-plane-move)
[341.160482] Subtest fbc-psr2-cursor-plane-move: SKIP (0.000s)
[341.218933] [058/133] (686s left) perf_pmu (init-wait)
[341.291440] Starting subtest: init-wait
[341.292416] Starting dynamic subtest: rcs0
[341.294452] Dynamic subtest rcs0: SUCCESS (0.002s)
[341.305008] Starting dynamic subtest: bcs0
[341.305963] Dynamic subtest bcs0: SUCCESS (0.000s)
[341.316288] Starting dynamic subtest: vcs0
[341.317197] Dynamic subtest vcs0: SUCCESS (0.000s)
[341.328210] Starting dynamic subtest: vcs1
[341.329417] Dynamic subtest vcs1: SUCCESS (0.001s)
[341.339776] Starting dynamic subtest: vecs0
[341.340886] Dynamic subtest vecs0: SUCCESS (0.000s)
[341.350883] Starting dynamic subtest: vecs1
[341.352137] Dynamic subtest vecs1: SUCCESS (0.000s)
[341.362587] Starting dynamic subtest: ccs0
[341.363701] Dynamic subtest ccs0: SUCCESS (0.000s)
[341.364835] Subtest init-wait: SUCCESS (0.010s)
[341.508081] [059/133] (686s left) prime_self_import (basic-with_two_bos)
[341.557554] Starting subtest: basic-with_two_bos
[341.602579] Subtest basic-with_two_bos: SUCCESS (0.046s)
[341.757407] [060/133] (686s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[343.277042] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[343.278899] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[343.486263] [061/133] (684s left) kms_psr (fbc-pr-cursor-render)
[345.003509] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[345.068953] [062/133] (683s left) kms_getfb (getfb-handle-valid)
[346.587786] Starting subtest: getfb-handle-valid
[346.588589] Subtest getfb-handle-valid: SUCCESS (0.000s)
[346.759237] [063/133] (681s left) gem_pxp (create-regular-buffer)
[349.399010] Starting subtest: create-regular-buffer
[349.401297] Subtest create-regular-buffer: SKIP (0.000s)
[349.498759] [064/133] (678s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[351.067161] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[351.173659] [065/133] (677s left) gem_exec_reloc (basic-gtt)
[351.266906] Subtest basic-gtt: SKIP (0.000s)
[351.333931] [066/133] (677s left) gem_sync (basic-each)
[351.423746] Starting subtest: basic-each
[354.164225] Subtest basic-each: SUCCESS (2.740s)
[354.449768] [067/133] (674s left) gem_exec_reloc (basic-wc-read-active)
[354.536010] Subtest basic-wc-read-active: SKIP (0.000s)
[354.617964] [068/133] (674s left) prime_vgem (shrink)
[354.717569] Starting subtest: shrink
[354.724324] Subtest shrink: SUCCESS (0.007s)
[354.841785] [069/133] (673s left) kms_cursor_crc (cursor-suspend)
[356.433312] Starting subtest: cursor-suspend
[356.435430] Starting dynamic subtest: pipe-A-HDMI-A-3
[396.525450] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (8.075s)
[396.550094] Starting dynamic subtest: pipe-D-HDMI-A-3
[436.408899] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (7.367s)
[436.409759] Subtest cursor-suspend: SUCCESS (15.446s)
[440.882604] [070/133] (591s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[442.400861] Starting subtest: cursorB-vs-flipA-atomic-transitions
[442.404137] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.002s)
[442.510737] [071/133] (590s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[444.045923] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[444.047869] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[444.169948] [072/133] (588s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[445.719712] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[446.986139] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.266s)
[447.178953] [073/133] (585s left) gem_exec_parallel (fds)
[447.286275] Starting subtest: fds
[447.287238] Starting dynamic subtest: rcs0
[450.630645] Dynamic subtest rcs0: SUCCESS (3.343s)
[450.643453] Starting dynamic subtest: bcs0
[454.325743] Dynamic subtest bcs0: SUCCESS (3.694s)
[454.338538] Starting dynamic subtest: vcs0
[457.664985] Dynamic subtest vcs0: SUCCESS (3.338s)
[457.678116] Starting dynamic subtest: vcs1
[462.510361] Dynamic subtest vcs1: SUCCESS (4.844s)
[462.523113] Starting dynamic subtest: vecs0
[465.929832] Dynamic subtest vecs0: SUCCESS (3.418s)
[465.943009] Starting dynamic subtest: vecs1
[469.745541] Dynamic subtest vecs1: SUCCESS (3.815s)
[469.758450] Starting dynamic subtest: ccs0
[473.595789] Dynamic subtest ccs0: SUCCESS (3.849s)
[473.597049] Subtest fds: SUCCESS (26.310s)
[473.880415] [074/133] (559s left) gem_eio (kms)
[475.595074] Starting subtest: kms
[506.442340] Subtest kms: SUCCESS (30.847s)
[506.706499] [075/133] (526s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[508.220883] Starting subtest: short-flip-after-cursor-atomic-transitions
[509.244996] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (1.023s)
[509.490118] [076/133] (523s left) perf (sysctl-defaults)
[509.596452] Starting subtest: sysctl-defaults
[509.597322] Subtest sysctl-defaults: SUCCESS (0.000s)
[509.781056] [077/133] (523s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[511.306993] Starting subtest: 4-tiled-8bpp-rotate-270
[511.365218] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.057s)
[511.545607] [078/133] (521s left) kms_atomic (plane-cursor-legacy)
[513.066495] Starting subtest: plane-cursor-legacy
[513.069188] Starting dynamic subtest: pipe-A-HDMI-A-3
[513.606877] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.539s)
[513.608006] Subtest plane-cursor-legacy: SUCCESS (0.541s)
[513.805634] [079/133] (519s left) kms_hdmi_inject (inject-4k)
[513.938948] Starting subtest: inject-4k
[514.098277] Subtest inject-4k: SUCCESS (0.160s)
[514.994491] [080/133] (518s left) kms_big_fb (linear-8bpp-rotate-270)
[516.528885] Starting subtest: linear-8bpp-rotate-270
[516.591856] Subtest linear-8bpp-rotate-270: SKIP (0.062s)
[516.792538] [081/133] (516s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[518.313463] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[518.315176] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[518.538773] [082/133] (515s left) gem_ctx_persistence (engines-hostile-preempt)
[518.643348] Starting subtest: engines-hostile-preempt
[518.644276] Starting dynamic subtest: rcs0
[518.741130] Dynamic subtest rcs0: SUCCESS (0.097s)
[518.756379] Starting dynamic subtest: bcs0
[518.784271] Dynamic subtest bcs0: SUCCESS (0.042s)
[518.807109] Starting dynamic subtest: vcs0
[518.813043] Dynamic subtest vcs0: SUCCESS (0.027s)
[518.835082] Starting dynamic subtest: vcs1
[518.889285] Dynamic subtest vcs1: SUCCESS (0.075s)
[518.914883] Starting dynamic subtest: vecs0
[518.935099] Dynamic subtest vecs0: SUCCESS (0.044s)
[518.960229] Starting dynamic subtest: vecs1
[518.988120] Dynamic subtest vecs1: SUCCESS (0.051s)
[519.009438] Starting dynamic subtest: ccs0
[519.044465] Dynamic subtest ccs0: SUCCESS (0.055s)
[519.045685] Subtest engines-hostile-preempt: SUCCESS (0.402s)
[519.212582] [083/133] (514s left) gem_gpgpu_fill (offset-16x16)
[519.296918] Starting subtest: offset-16x16
[519.329096] Subtest offset-16x16: SUCCESS (0.032s)
[519.539536] [084/133] (514s left) gem_exec_params (readonly)
[519.625710] Starting subtest: readonly
[519.628182] Subtest readonly: SUCCESS (0.002s)
[519.799657] [085/133] (514s left) gem_ppgtt (blt-vs-render-ctxn)
[519.886910] Starting subtest: blt-vs-render-ctxN
[552.595589] Subtest blt-vs-render-ctxN: SUCCESS (32.708s)
[552.800529] [086/133] (481s left) syncobj_wait (multi-wait-submitted)
[552.937909] Starting subtest: multi-wait-submitted
[553.041636] Subtest multi-wait-submitted: SUCCESS (0.103s)
[553.177644] [087/133] (480s left) gem_vm_create (invalid-create)
[553.266111] Starting subtest: invalid-create
[553.270892] Subtest invalid-create: SUCCESS (0.005s)
[553.400551] [088/133] (480s left) kms_tv_load_detect (load-detect)
[553.480892] Subtest load-detect: SKIP (0.000s)
[553.567773] [089/133] (480s left) kms_plane_scaling (planes-upscale-factor-0-25)
[555.088868] Starting subtest: planes-upscale-factor-0-25
[555.089722] Starting dynamic subtest: pipe-A
[555.191334] Dynamic subtest pipe-A: SUCCESS (0.103s)
[555.212341] Starting dynamic subtest: pipe-B
[555.354283] Dynamic subtest pipe-B: SUCCESS (0.162s)
[555.377592] Starting dynamic subtest: pipe-C
[555.514220] Dynamic subtest pipe-C: SUCCESS (0.158s)
[555.531142] Starting dynamic subtest: pipe-D
[555.639959] Dynamic subtest pipe-D: SUCCESS (0.125s)
[555.640850] Subtest planes-upscale-factor-0-25: SUCCESS (0.553s)
[555.884298] [090/133] (478s left) syncobj_timeline (multi-wait-all-available-submitted)
[555.964090] Starting subtest: multi-wait-all-available-submitted
[555.965009] Subtest multi-wait-all-available-submitted: SUCCESS (0.001s)
[556.120019] [091/133] (478s left) perf (per-context-mode-unprivileged)
[556.372957] Starting subtest: per-context-mode-unprivileged
[556.374957] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[556.430834] [092/133] (478s left) kms_flip (2x-flip-vs-expired-vblank)
[557.947661] Starting subtest: 2x-flip-vs-expired-vblank
[557.959802] Subtest 2x-flip-vs-expired-vblank: SKIP (0.013s)
[558.082448] [093/133] (476s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[559.620716] Starting subtest: flip-vs-cursor-crc-atomic
[560.187858] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.567s)
[560.394790] [094/133] (474s left) kms_plane_alpha_blend (constant-alpha-max)
[561.912179] Starting subtest: constant-alpha-max
[562.167031] Starting dynamic subtest: pipe-A-HDMI-A-3
[563.031946] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.864s)
[563.045931] Starting dynamic subtest: pipe-D-HDMI-A-3
[563.908208] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.875s)
[563.909152] Subtest constant-alpha-max: SUCCESS (1.996s)
[564.094476] [095/133] (470s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[565.616876] Starting subtest: fbcpsr-tiling-y
[565.618638] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[565.797669] [096/133] (469s left) i915_hangman (engine-engine-error)
[565.906126] Starting subtest: engine-engine-error
[565.907027] Starting dynamic subtest: rcs0
[566.703382] Dynamic subtest rcs0: SUCCESS (0.797s)
[566.722647] Starting dynamic subtest: bcs0
[567.419040] Dynamic subtest bcs0: SUCCESS (0.714s)
[567.432266] Starting dynamic subtest: vcs0
[568.131073] Dynamic subtest vcs0: SUCCESS (0.711s)
[568.145852] Starting dynamic subtest: vcs1
[568.848231] Dynamic subtest vcs1: SUCCESS (0.716s)
[568.863162] Starting dynamic subtest: vecs0
[569.565046] Dynamic subtest vecs0: SUCCESS (0.716s)
[569.579508] Starting dynamic subtest: vecs1
[570.294421] Dynamic subtest vecs1: SUCCESS (0.728s)
[570.310192] Starting dynamic subtest: ccs0
[571.049079] Dynamic subtest ccs0: SUCCESS (0.753s)
[571.049979] Subtest engine-engine-error: SUCCESS (5.143s)
[571.194240] [097/133] (463s left) gem_lmem_swapping (random)
[575.849049] Starting subtest: random
[575.850303] Starting dynamic subtest: lmem0
[576.836443] Dynamic subtest lmem0: SUCCESS (0.987s)
[576.837239] Subtest random: SUCCESS (0.988s)
[579.628836] [FACT gem_lmem_swapping (random)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[579.630025] [FACT gem_lmem_swapping (random)] deleted: kernel.kmod_is_loaded.i915: true
[579.632081] [098/133] (455s left) kms_invalid_mode (clock-too-high)
[584.658231] Starting subtest: clock-too-high
[584.659158] Starting dynamic subtest: pipe-A-HDMI-A-3
[584.705145] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.046s)
[584.718373] Starting dynamic subtest: pipe-B-HDMI-A-3
[584.720082] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.001s)
[584.731887] Starting dynamic subtest: pipe-C-HDMI-A-3
[584.733700] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.001s)
[584.745234] Starting dynamic subtest: pipe-D-HDMI-A-3
[584.747013] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.001s)
[584.754938] Subtest clock-too-high: SUCCESS (0.056s)
[584.960906] [FACT kms_invalid_mode (clock-too-high)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[584.963450] [FACT kms_invalid_mode (clock-too-high)] new: kernel.kmod_is_loaded.i915: true
[584.966132] [099/133] (450s left) gem_exec_schedule (preempt-engines)
[585.067158] Starting subtest: preempt-engines
[585.068037] Starting dynamic subtest: rcs0
[587.355749] Dynamic subtest rcs0: SUCCESS (2.289s)
[587.369598] Starting dynamic subtest: bcs0
[589.537677] Dynamic subtest bcs0: SUCCESS (2.179s)
[589.552060] Starting dynamic subtest: vcs0
[591.868060] Dynamic subtest vcs0: SUCCESS (2.327s)
[591.882872] Starting dynamic subtest: vcs1
[594.266539] Dynamic subtest vcs1: SUCCESS (2.395s)
[594.280510] Starting dynamic subtest: vecs0
[596.595658] Dynamic subtest vecs0: SUCCESS (2.326s)
[596.610411] Starting dynamic subtest: vecs1
[598.926143] Dynamic subtest vecs1: SUCCESS (2.327s)
[598.944369] Starting dynamic subtest: ccs0
[601.145229] Dynamic subtest ccs0: SUCCESS (2.215s)
[601.146985] Subtest preempt-engines: SUCCESS (16.080s)
[601.515355] [100/133] (433s left) gem_exec_fence (syncobj-invalid-flags)
[602.099108] Starting subtest: syncobj-invalid-flags
[602.100087] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[602.481317] [101/133] (432s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[602.561258] Starting subtest: etime-multi-wait-all-for-submit-submitted
[602.665247] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.104s)
[602.807488] [102/133] (432s left) gem_ctx_create (basic-files)
[602.898413] Starting subtest: basic-files
[604.912205] Subtest basic-files: SUCCESS (2.014s)
[605.300131] [103/133] (430s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[606.817688] Starting subtest: fbcpsr-1p-rte
[606.819422] Subtest fbcpsr-1p-rte: SKIP (0.000s)
[606.966091] [104/133] (428s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[608.525963] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[608.527970] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[608.701370] [105/133] (426s left) kms_pm_dc (dc5-retention-flops)
[611.256310] Starting subtest: dc5-retention-flops
[611.257992] Subtest dc5-retention-flops: SKIP (0.000s)
[611.358906] [106/133] (424s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[611.462211] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[611.463181] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[611.619697] [107/133] (424s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[615.566328] Starting subtest: modeset-lpsp-stress-no-wait
[616.374711] Subtest modeset-lpsp-stress-no-wait: SKIP (0.806s)
[616.607606] [108/133] (419s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[618.122873] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[618.123703] Starting dynamic subtest: pipe-A-HDMI-A-3
[618.132148] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[618.143924] Starting dynamic subtest: pipe-B-HDMI-A-3
[618.152495] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[618.164293] Starting dynamic subtest: pipe-C-HDMI-A-3
[618.179322] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[618.190648] Starting dynamic subtest: pipe-D-HDMI-A-3
[618.199811] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[618.201871] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SKIP (0.008s)
[618.397940] [109/133] (417s left) kms_cursor_crc (cursor-random-32x32)
[620.017027] Starting subtest: cursor-random-32x32
[620.072154] Subtest cursor-random-32x32: SKIP (0.054s)
[620.476256] [110/133] (415s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[621.991907] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[621.993587] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[622.221466] [111/133] (413s left) kms_chamelium_edid (dp-edid-resolution-list)
[623.798981] Subtest dp-edid-resolution-list: SKIP (0.000s)
[623.908541] [112/133] (412s left) gem_ctx_param (basic)
[623.997539] Starting subtest: basic
[623.999884] Subtest basic: SUCCESS (0.001s)
[624.135756] [113/133] (412s left) kms_psr (psr-sprite-render)
[625.655186] Subtest psr-sprite-render: SKIP (0.000s)
[625.717242] [114/133] (410s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[627.244245] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[627.246088] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[627.386876] [115/133] (408s left) kms_lease (page-flip-implicit-plane)
[628.925837] Starting subtest: page-flip-implicit-plane
[628.926816] Starting dynamic subtest: pipe-A-HDMI-A-3
[629.340005] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.413s)
[629.376788] Starting dynamic subtest: pipe-B-HDMI-A-3
[629.621859] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.275s)
[629.636068] Starting dynamic subtest: pipe-C-HDMI-A-3
[629.879923] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.256s)
[629.894050] Starting dynamic subtest: pipe-D-HDMI-A-3
[630.140895] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.259s)
[630.142829] Subtest page-flip-implicit-plane: SUCCESS (1.216s)
[630.407154] [116/133] (406s left) api_intel_allocator (reloc-allocator)
[630.484096] Starting subtest: reloc-allocator
[630.485007] Starting dynamic subtest: basic
[630.510611] Dynamic subtest basic: SUCCESS (0.026s)
[630.524280] Starting dynamic subtest: parallel-one
[630.525186] Dynamic subtest parallel-one: SUCCESS (0.005s)
[630.537315] Starting dynamic subtest: print
[630.538560] Dynamic subtest print: SUCCESS (0.000s)
[630.550415] Starting dynamic subtest: reuse
[630.551317] Dynamic subtest reuse: SUCCESS (0.000s)
[630.562908] Starting dynamic subtest: fork-reopen-allocator
[630.564057] Dynamic subtest fork-reopen-allocator: SUCCESS (0.014s)
[630.565189] Subtest reloc-allocator: SUCCESS (0.051s)
[630.696126] [117/133] (405s left) gem_ctx_persistence (heartbeat-hostile)
[630.783913] Starting subtest: heartbeat-hostile
[630.785893] Subtest heartbeat-hostile: SKIP (0.000s)
[630.908220] [118/133] (405s left) kms_flip (flip-vs-blocking-wf-vblank)
[632.426872] Starting subtest: flip-vs-blocking-wf-vblank
[632.431188] Starting dynamic subtest: A-HDMI-A3
[640.473575] Dynamic subtest A-HDMI-A3: SUCCESS (8.042s)
[640.488197] Starting dynamic subtest: B-HDMI-A3
[648.446010] Dynamic subtest B-HDMI-A3: SUCCESS (7.971s)
[648.460097] Starting dynamic subtest: C-HDMI-A3
[656.418263] Dynamic subtest C-HDMI-A3: SUCCESS (7.971s)
[656.432289] Starting dynamic subtest: D-HDMI-A3
[664.389987] Dynamic subtest D-HDMI-A3: SUCCESS (7.970s)
[664.390950] Subtest flip-vs-blocking-wf-vblank: SUCCESS (31.965s)
[664.654934] [119/133] (371s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[666.173660] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[668.415763] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (2.243s)
[668.624974] [120/133] (368s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[670.151636] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[670.153649] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[670.290877] [121/133] (366s left) gem_mmap_wc (close)
[670.394028] Subtest close: SKIP (0.000s)
[670.462025] [122/133] (366s left) gem_pxp (reject-modify-context-protection-off-1)
[673.072100] Starting subtest: reject-modify-context-protection-off-1
[673.074297] Subtest reject-modify-context-protection-off-1: SKIP (0.000s)
[673.214215] [123/133] (363s left) gen7_exec_parse (basic-offset)
[673.299614] Subtest basic-offset: SKIP (0.000s)
[673.381830] [124/133] (363s left) kms_chamelium_color (ctm-0-75)
[674.898136] Subtest ctm-0-75: SKIP (0.000s)
[674.963410] [125/133] (362s left) gem_mmap_gtt (hang-user)
[675.044786] Subtest hang-user: SKIP (0.000s)
[675.112626] [126/133] (361s left) kms_vblank (wait-forked-busy-hang)
[676.631876] Starting subtest: wait-forked-busy-hang
[676.634245] Starting dynamic subtest: pipe-A-HDMI-A-3
[703.091286] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (26.457s)
[703.106377] Starting dynamic subtest: pipe-D-HDMI-A-3
[728.034017] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (24.938s)
[728.034943] Subtest wait-forked-busy-hang: SUCCESS (51.402s)
[728.280415] [127/133] (308s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[729.793870] Starting subtest: async-flip-with-page-flip-events-linear
[730.021046] Starting dynamic subtest: pipe-A-HDMI-A-3
[732.271464] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.250s)
[732.438410] Starting dynamic subtest: pipe-B-HDMI-A-3
[734.488777] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (2.060s)
[734.652322] Starting dynamic subtest: pipe-C-HDMI-A-3
[736.702993] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (2.061s)
[736.863462] Starting dynamic subtest: pipe-D-HDMI-A-3
[738.913080] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.060s)
[738.914104] Subtest async-flip-with-page-flip-events-linear: SUCCESS (9.120s)
[739.270397] [128/133] (297s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[740.789763] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[740.791562] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[740.937638] [129/133] (296s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[742.483851] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[742.485430] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[742.645417] [130/133] (294s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[744.185897] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[744.186774] Starting dynamic subtest: pipe-A-HDMI-A-3
[744.190117] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[744.202263] Starting dynamic subtest: pipe-B-HDMI-A-3
[744.205804] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[744.218006] Starting dynamic subtest: pipe-C-HDMI-A-3
[744.221692] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[744.233694] Starting dynamic subtest: pipe-D-HDMI-A-3
[744.237066] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[744.238905] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SKIP (0.008s)
[744.477647] [131/133] (292s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[745.994875] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[745.995737] Starting dynamic subtest: pipe-A-valid-mode
[746.883883] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.888s)
[746.885164] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (0.890s)
[747.090169] [132/133] (290s left) gem_workarounds (reset-context)
[747.187677] Starting subtest: reset-context
[747.417897] Subtest reset-context: SUCCESS (0.230s)
[747.557854] [133/133] (290s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[749.076913] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[749.078717] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[749.242244] Closing watchdogs
results: parsing output: 0/ for test: kms_flip
results: parsing output: 1/ for test: kms_plane
results: parsing output: 2/ for test: kms_psr
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_dither
results: parsing output: 5/ for test: gem_spin_batch
results: parsing output: 6/ for test: kms_vblank
results: parsing output: 7/ for test: syncobj_timeline
results: parsing output: 8/ for test: kms_content_protection
results: parsing output: 9/ for test: kms_big_fb
results: parsing output: 10/ for test: kms_flip
results: parsing output: 11/ for test: gem_ccs
results: parsing output: 12/ for test: syncobj_timeline
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: gem_render_copy
results: parsing output: 15/ for test: kms_cursor_crc
results: parsing output: 16/ for test: gem_exec_reloc
results: parsing output: 17/ for test: i915_suspend
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_getfb
results: parsing output: 21/ for test: gem_exec_balancer
results: parsing output: 22/ for test: kms_plane_lowres
results: parsing output: 23/ for test: gen9_exec_parse
results: parsing output: 24/ for test: kms_rotation_crc
results: parsing output: 25/ for test: kms_getfb
results: parsing output: 26/ for test: kms_explicit_fence
results: parsing output: 27/ for test: syncobj_timeline
results: parsing output: 28/ for test: kms_psr2_sf
results: parsing output: 29/ for test: gem_ccs
results: parsing output: 30/ for test: i915_pm_rps
results: parsing output: 31/ for test: kms_addfb_basic
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_plane_scaling
results: parsing output: 34/ for test: kms_ccs
results: parsing output: 35/ for test: kms_ccs
results: parsing output: 36/ for test: perf
results: parsing output: 37/ for test: kms_flip
results: parsing output: 38/ for test: gem_exec_endless
results: parsing output: 39/ for test: gem_readwrite
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: gem_busy
results: parsing output: 42/ for test: kms_color
results: parsing output: 43/ for test: perf_pmu
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_psr2_sf
results: parsing output: 46/ for test: dumb_buffer
results: parsing output: 47/ for test: syncobj_basic
results: parsing output: 48/ for test: gem_exec_schedule
results: parsing output: 49/ for test: kms_cursor_legacy
results: parsing output: 50/ for test: kms_psr
results: parsing output: 51/ for test: gem_exec_schedule
results: parsing output: 52/ for test: syncobj_wait
results: parsing output: 53/ for test: api_intel_bb
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: gem_eio
results: parsing output: 56/ for test: kms_psr
results: parsing output: 57/ for test: perf_pmu
results: parsing output: 58/ for test: prime_self_import
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_psr
results: parsing output: 61/ for test: kms_getfb
results: parsing output: 62/ for test: gem_pxp
results: parsing output: 63/ for test: kms_chamelium_hpd
results: parsing output: 64/ for test: gem_exec_reloc
results: parsing output: 65/ for test: gem_sync
results: parsing output: 66/ for test: gem_exec_reloc
results: parsing output: 67/ for test: prime_vgem
results: parsing output: 68/ for test: kms_cursor_crc
results: parsing output: 69/ for test: kms_cursor_legacy
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_big_fb
results: parsing output: 72/ for test: gem_exec_parallel
results: parsing output: 73/ for test: gem_eio
results: parsing output: 74/ for test: kms_cursor_legacy
results: parsing output: 75/ for test: perf
results: parsing output: 76/ for test: kms_big_fb
results: parsing output: 77/ for test: kms_atomic
results: parsing output: 78/ for test: kms_hdmi_inject
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: gem_ctx_persistence
results: parsing output: 82/ for test: gem_gpgpu_fill
results: parsing output: 83/ for test: gem_exec_params
results: parsing output: 84/ for test: gem_ppgtt
results: parsing output: 85/ for test: syncobj_wait
results: parsing output: 86/ for test: gem_vm_create
results: parsing output: 87/ for test: kms_tv_load_detect
results: parsing output: 88/ for test: kms_plane_scaling
results: parsing output: 89/ for test: syncobj_timeline
results: parsing output: 90/ for test: perf
results: parsing output: 91/ for test: kms_flip
results: parsing output: 92/ for test: kms_cursor_legacy
results: parsing output: 93/ for test: kms_plane_alpha_blend
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: i915_hangman
results: parsing output: 96/ for test: gem_lmem_swapping
results: parsing output: 97/ for test: kms_invalid_mode
results: parsing output: 98/ for test: gem_exec_schedule
results: parsing output: 99/ for test: gem_exec_fence
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: gem_ctx_create
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: kms_pm_dc
results: parsing output: 105/ for test: syncobj_timeline
results: parsing output: 106/ for test: kms_pm_rpm
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: kms_cursor_crc
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_chamelium_edid
results: parsing output: 111/ for test: gem_ctx_param
results: parsing output: 112/ for test: kms_psr
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: kms_lease
results: parsing output: 115/ for test: api_intel_allocator
results: parsing output: 116/ for test: gem_ctx_persistence
results: parsing output: 117/ for test: kms_flip
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: gem_mmap_wc
results: parsing output: 121/ for test: gem_pxp
results: parsing output: 122/ for test: gen7_exec_parse
results: parsing output: 123/ for test: kms_chamelium_color
results: parsing output: 124/ for test: gem_mmap_gtt
results: parsing output: 125/ for test: kms_vblank
results: parsing output: 126/ for test: kms_async_flips
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_ccs
results: parsing output: 130/ for test: kms_flip_scaled_crc
results: parsing output: 131/ for test: gem_workarounds
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.