[58.138973] Initializing watchdogs
[58.139096]   /dev/watchdog0
[58.153476] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.157829] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.159945] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.163287] [001/130] (960s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[58.619085] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[59.452178] [002/130] (959s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite)
[59.564570] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite
[64.205585] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (4.645s)
[64.322692] [003/130] (954s left) prime_self_import (export-vs-gem_close-race)
[64.367080] Starting subtest: export-vs-gem_close-race
[69.453375] Subtest export-vs-gem_close-race: SUCCESS (5.086s)
[69.520764] [004/130] (949s left) kms_properties (get_properties-sanity-atomic)
[69.632105] Starting subtest: get_properties-sanity-atomic
[69.634599] Subtest get_properties-sanity-atomic: SUCCESS (0.002s)
[69.702973] [005/130] (949s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[69.812858] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[69.817282] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[69.907694] [006/130] (948s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[70.004522] Starting subtest: fbc-farfromfence-mmap-gtt
[70.009062] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[70.105869] [007/130] (948s left) gem_exec_schedule (fifo)
[70.187173] Starting subtest: fifo
[70.189470] Starting dynamic subtest: rcs0
[70.285703] Dynamic subtest rcs0: SUCCESS (0.104s)
[70.295668] Starting dynamic subtest: vcs0
[70.365175] Dynamic subtest vcs0: SUCCESS (0.079s)
[70.375615] Starting dynamic subtest: vcs1
[70.442312] Dynamic subtest vcs1: SUCCESS (0.078s)
[70.451331] Starting dynamic subtest: vecs0
[70.522204] Dynamic subtest vecs0: SUCCESS (0.080s)
[70.528661] Starting dynamic subtest: ccs0
[70.603346] Dynamic subtest ccs0: SUCCESS (0.081s)
[70.605485] Subtest fifo: SUCCESS (0.423s)
[72.104114] [008/130] (946s left) gem_eio (in-flight-1us)
[72.300268] Starting subtest: in-flight-1us
[80.404255] Subtest in-flight-1us: SUCCESS (8.103s)
[80.578035] [FACT gem_eio (in-flight-1us)] new: kernel.kmod_is_loaded.vgem: true
[80.581007] [009/130] (938s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[80.698605] Starting subtest: cursorA-vs-flipB-legacy
[80.702593] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s)
[80.843945] [010/130] (938s left) kms_properties (plane-properties-atomic)
[80.938851] Starting subtest: plane-properties-atomic
[80.941154] Starting dynamic subtest: pipe-A-eDP-1
[81.527605] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.587s)
[81.536160] Starting dynamic subtest: pipe-B-eDP-1
[82.790491] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.260s)
[82.798939] Starting dynamic subtest: pipe-C-eDP-1
[84.013495] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.224s)
[84.022338] Starting dynamic subtest: pipe-D-eDP-1
[85.243162] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.230s)
[85.245572] Subtest plane-properties-atomic: SUCCESS (4.304s)
[86.034603] [011/130] (932s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[86.151691] Starting subtest: short-flip-after-cursor-atomic-transitions
[87.115025] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.964s)
[87.956874] [012/130] (931s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[88.068899] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[89.010605] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (0.944s)
[89.153286] [013/130] (929s left) syncobj_wait (single-wait-all-signaled)
[89.215455] Starting subtest: single-wait-all-signaled
[89.217447] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[89.311819] [014/130] (929s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[89.410622] Starting subtest: 2x-plain-flip-ts-check-interruptible
[89.423891] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.010s)
[89.491238] [015/130] (929s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[89.598576] Starting subtest: fbcpsr-suspend
[128.031865] Subtest fbcpsr-suspend: SUCCESS (7.659s)
[128.148422] [016/130] (921s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[128.246651] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[128.251913] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[129.361558] [017/130] (920s left) kms_pm_rpm (modeset-non-lpsp-stress)
[130.898575] Starting subtest: modeset-non-lpsp-stress
[132.052522] Subtest modeset-non-lpsp-stress: SKIP (1.148s)
[132.403453] [018/130] (917s left) gem_exec_whisper (basic-fds-priority)
[132.472815] Starting subtest: basic-fds-priority
[157.422297] Subtest basic-fds-priority: SUCCESS (24.941s)
[157.608841] [019/130] (892s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[162.648575] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[162.651557] Starting dynamic subtest: pipe-A-eDP-1
[169.755185] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.102s)
[169.764371] Starting dynamic subtest: pipe-B-eDP-1
[176.384270] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.626s)
[176.387052] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (13.732s)
[177.245490] [020/130] (872s left) kms_dp_link_training (non-uhbr-sst)
[177.346171] Starting subtest: non-uhbr-sst
[177.357829] Subtest non-uhbr-sst: SKIP (0.000s)
[177.413338] [021/130] (872s left) gem_mmap_offset (pf-nonblock)
[177.472758] Starting subtest: pf-nonblock
[177.478766] Subtest pf-nonblock: SUCCESS (0.007s)
[177.587295] [022/130] (872s left) kms_vblank (wait-forked-busy-hang)
[177.676874] Starting subtest: wait-forked-busy-hang
[177.679613] Starting dynamic subtest: pipe-A-eDP-1
[204.464139] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.779s)
[204.477594] Starting dynamic subtest: pipe-D-eDP-1
[229.467310] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.003s)
[229.469862] Subtest wait-forked-busy-hang: SUCCESS (51.785s)
[230.304166] [023/130] (819s left) kms_feature_discovery (chamelium)
[230.411045] Starting subtest: chamelium
[230.415992] Subtest chamelium: SKIP (0.000s)
[230.475812] [024/130] (819s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[230.567400] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[230.569838] Starting dynamic subtest: pipe-A
[230.651289] Dynamic subtest pipe-A: SUCCESS (0.083s)
[230.659766] Starting dynamic subtest: pipe-B
[231.824412] Dynamic subtest pipe-B: SUCCESS (1.172s)
[231.839256] Starting dynamic subtest: pipe-C
[232.930216] Dynamic subtest pipe-C: SUCCESS (1.105s)
[232.939282] Starting dynamic subtest: pipe-D
[234.051497] Dynamic subtest pipe-D: SUCCESS (1.120s)
[234.054216] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.484s)
[235.203455] [025/130] (815s left) gem_exec_fence (syncobj-timeline-unused-fence)
[235.786406] Starting subtest: syncobj-timeline-unused-fence
[235.802626] Subtest syncobj-timeline-unused-fence: SUCCESS (0.009s)
[236.814765] [026/130] (813s left) kms_atomic_transition (modeset-transition)
[236.908731] Starting subtest: modeset-transition
[236.911075] Starting dynamic subtest: 1x-outputs
[247.420098] Dynamic subtest 1x-outputs: SUCCESS (10.511s)
[247.697816] Subtest modeset-transition: SUCCESS (10.787s)
[248.541615] [027/130] (801s left) drm_fdinfo (virtual-busy-idle-all)
[248.585633] Starting subtest: virtual-busy-idle-all
[248.591029] Subtest virtual-busy-idle-all: SKIP (0.000s)
[248.641809] [028/130] (801s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[248.745039] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[248.750269] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[248.857825] [029/130] (801s left) gem_spin_batch (spin-each)
[248.928418] Starting subtest: spin-each
[252.205266] Subtest spin-each: SUCCESS (3.269s)
[252.802655] [030/130] (797s left) gem_fence_thrash (bo-write-verify-threaded-none)
[252.838655] Starting subtest: bo-write-verify-threaded-none
[252.873230] Subtest bo-write-verify-threaded-none: SKIP (0.031s)
[252.936550] [031/130] (797s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[253.036626] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[253.039154] Starting dynamic subtest: pipe-A-eDP-1
[268.905282] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.443s)
[268.915479] Starting dynamic subtest: pipe-B-eDP-1
[285.800038] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.330s)
[285.810877] Starting dynamic subtest: pipe-C-eDP-1
[302.777117] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.300s)
[302.786348] Starting dynamic subtest: pipe-D-eDP-1
[319.775379] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.237s)
[319.778403] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (8.314s)
[320.982862] [032/130] (787s left) core_auth (getclient-master-drop)
[321.019072] Starting subtest: getclient-master-drop
[321.040125] Subtest getclient-master-drop: SUCCESS (0.021s)
[321.151856] [033/130] (787s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[321.258043] Starting subtest: coverage-vs-premult-vs-constant
[321.679382] Starting dynamic subtest: pipe-A-eDP-1
[322.248347] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.567s)
[322.258190] Starting dynamic subtest: pipe-D-eDP-1
[323.549127] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.297s)
[323.551657] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.287s)
[324.332376] [034/130] (784s left) kms_legacy_colorkey (basic)
[324.429167] Starting subtest: basic
[324.431938] Starting dynamic subtest: pipe-A
[324.475968] Dynamic subtest pipe-A: SUCCESS (0.045s)
[324.485499] Starting dynamic subtest: pipe-B
[324.488282] Dynamic subtest pipe-B: SUCCESS (0.000s)
[324.496166] Starting dynamic subtest: pipe-C
[324.498809] Dynamic subtest pipe-C: SUCCESS (0.000s)
[324.506637] Starting dynamic subtest: pipe-D
[324.508931] Dynamic subtest pipe-D: SUCCESS (0.000s)
[324.511350] Subtest basic: SUCCESS (0.050s)
[324.543506] [035/130] (784s left) gem_userptr_blits (unsync-unmap-cycles)
[324.611243] Subtest unsync-unmap-cycles: SKIP (0.000s)
[324.748558] [036/130] (784s left) kms_selftest (drm_dp_mst_helper)
[324.784055] Starting subtest: drm_dp_mst_helper
[324.794775] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[324.909995] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.114s)
[324.920660] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[325.029099] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.119s)
[325.038431] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[325.167335] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.135s)
[325.170111] Subtest drm_dp_mst_helper: SUCCESS (0.381s)
[325.377735] [037/130] (783s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[325.480289] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[325.486341] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[325.562047] [038/130] (783s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[325.627605] Subtest untiled-to-tiled: SKIP (0.000s)
[325.686950] [039/130] (783s left) drm_fdinfo (context-close-stress)
[325.729175] Starting subtest: context-close-stress
[336.480250] Subtest context-close-stress: SUCCESS (10.746s)
[336.548839] [040/130] (772s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[336.799359] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[336.805148] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[336.898653] [041/130] (772s left) gem_workarounds (suspend-resume)
[336.981369] Starting subtest: suspend-resume
[352.701237] Subtest suspend-resume: SUCCESS (1.194s)
[352.835433] [042/130] (771s left) kms_plane (plane-panning-top-left)
[352.942811] Starting subtest: plane-panning-top-left
[352.945071] Starting dynamic subtest: pipe-A
[354.613307] Dynamic subtest pipe-A: SUCCESS (1.665s)
[354.621629] Starting dynamic subtest: pipe-B
[356.869996] Dynamic subtest pipe-B: SUCCESS (2.251s)
[356.872263] Subtest plane-panning-top-left: SUCCESS (3.919s)
[357.649627] [043/130] (766s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[358.038769] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[358.857115] [044/130] (765s left) gem_exec_flush (basic-uc-set-default)
[358.923063] Starting subtest: basic-uc-set-default
[364.400379] Subtest basic-uc-set-default: SUCCESS (5.473s)
[364.584905] [045/130] (759s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[364.688328] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[364.692436] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[364.783393] [046/130] (759s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[364.843982] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[364.901459] [047/130] (759s left) gem_ctx_sseu (engines)
[364.971393] Subtest engines: SKIP (0.000s)
[365.051410] [048/130] (759s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[365.156447] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[366.123970] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (0.968s)
[366.263183] [049/130] (757s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[366.363778] Starting subtest: plane-upscale-20x20-with-modifiers
[366.365982] Starting dynamic subtest: pipe-A
[366.701624] Dynamic subtest pipe-A: SUCCESS (0.338s)
[366.709752] Starting dynamic subtest: pipe-B
[368.075344] Dynamic subtest pipe-B: SUCCESS (1.372s)
[368.083726] Starting dynamic subtest: pipe-C
[369.503759] Dynamic subtest pipe-C: SUCCESS (1.427s)
[369.514070] Starting dynamic subtest: pipe-D
[370.930060] Dynamic subtest pipe-D: SUCCESS (1.425s)
[370.932506] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.564s)
[372.094805] [050/130] (752s left) gem_exec_reloc (basic-wc-cpu)
[372.161233] Subtest basic-wc-cpu: SKIP (0.000s)
[372.247445] [051/130] (751s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[372.340026] Starting subtest: y-tiled-8bpp-rotate-0
[372.344144] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[372.450903] [052/130] (751s left) kms_invalid_mode (zero-vdisplay)
[372.546988] Starting subtest: zero-vdisplay
[372.549289] Starting dynamic subtest: pipe-A-eDP-1
[372.828442] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.281s)
[372.838341] Starting dynamic subtest: pipe-B-eDP-1
[372.840795] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[372.849564] Starting dynamic subtest: pipe-C-eDP-1
[372.851738] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[372.859846] Starting dynamic subtest: pipe-D-eDP-1
[372.861821] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[372.863805] Subtest zero-vdisplay: SUCCESS (0.286s)
[373.624234] [053/130] (750s left) i915_pm_rpm (reg-read-ioctl)
[375.774769] Starting subtest: reg-read-ioctl
[378.067619] Subtest reg-read-ioctl: SUCCESS (2.293s)
[378.424721] [054/130] (745s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[378.524260] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[378.526567] Starting dynamic subtest: pipe-A-default-mode
[378.836784] Dynamic subtest pipe-A-default-mode: SKIP (0.312s)
[378.841254] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.313s)
[379.636863] [055/130] (744s left) kms_hdr (static-toggle-dpms)
[379.736526] Starting subtest: static-toggle-dpms
[379.743388] Subtest static-toggle-dpms: SKIP (0.000s)
[379.805084] [056/130] (744s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[380.038571] Starting subtest: cursor-rapid-movement-512x512
[380.042773] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[380.192517] [057/130] (744s left) kms_vblank (ts-continuation-modeset-rpm)
[380.288521] Starting subtest: ts-continuation-modeset-rpm
[380.290844] Starting dynamic subtest: pipe-A-eDP-1
[382.825753] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.533s)
[382.839486] Starting dynamic subtest: pipe-D-eDP-1
[385.053591] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.225s)
[385.055981] Subtest ts-continuation-modeset-rpm: SUCCESS (4.761s)
[385.833511] [058/130] (738s left) kms_cursor_crc (cursor-random-512x512)
[386.098284] Starting subtest: cursor-random-512x512
[386.103085] Subtest cursor-random-512x512: SKIP (0.001s)
[386.264009] [059/130] (738s left) gem_exec_fence (basic-await)
[386.455783] Starting subtest: basic-await
[386.458173] Starting dynamic subtest: rcs0
[386.535600] Dynamic subtest rcs0: SUCCESS (0.080s)
[386.547170] Starting dynamic subtest: bcs0
[386.615335] Dynamic subtest bcs0: SUCCESS (0.078s)
[386.627682] Starting dynamic subtest: vcs0
[386.692926] Dynamic subtest vcs0: SUCCESS (0.077s)
[386.703573] Starting dynamic subtest: vcs1
[386.771227] Dynamic subtest vcs1: SUCCESS (0.076s)
[386.783063] Starting dynamic subtest: vecs0
[386.848170] Dynamic subtest vecs0: SUCCESS (0.076s)
[386.859903] Starting dynamic subtest: ccs0
[386.928005] Dynamic subtest ccs0: SUCCESS (0.078s)
[386.930500] Subtest basic-await: SUCCESS (0.473s)
[388.727547] [060/130] (735s left) kms_setmode (invalid-clone-exclusive-crtc)
[388.786516] Starting subtest: invalid-clone-exclusive-crtc
[388.793303] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[388.897572] [061/130] (735s left) kms_flip (2x-absolute-wf_vblank)
[389.006887] Starting subtest: 2x-absolute-wf_vblank
[389.017697] Subtest 2x-absolute-wf_vblank: SKIP (0.010s)
[389.132434] [062/130] (735s left) gem_basic (create-fd-close)
[389.185441] Starting subtest: create-fd-close
[389.189369] Subtest create-fd-close: SUCCESS (0.000s)
[389.301028] [063/130] (735s left) drm_read (short-buffer-block)
[389.459672] Starting subtest: short-buffer-block
[389.462975] Subtest short-buffer-block: SUCCESS (0.000s)
[389.607736] [064/130] (735s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[389.713283] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[389.716767] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[389.803153] [065/130] (734s left) kms_psr (fbc-pr-sprite-plane-onoff)
[389.899204] Starting subtest: fbc-pr-sprite-plane-onoff
[389.902738] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[389.971813] [066/130] (734s left) kms_psr (fbc-psr-sprite-blt)
[390.062064] Starting subtest: fbc-psr-sprite-blt
[390.064018] Starting dynamic subtest: eDP-1
[390.067567] Dynamic subtest eDP-1: SKIP (0.000s)
[390.071320] Subtest fbc-psr-sprite-blt: SKIP (0.001s)
[390.145322] [067/130] (734s left) gem_eio (wait-wedge-1us)
[390.364699] Starting subtest: wait-wedge-1us
[391.705933] Subtest wait-wedge-1us: SUCCESS (1.339s)
[391.857934] [068/130] (732s left) gem_wait (await)
[391.917579] Starting subtest: await
[391.919940] Starting dynamic subtest: all-engines
[393.043196] Dynamic subtest all-engines: SUCCESS (1.124s)
[393.059423] Starting dynamic subtest: rcs0
[394.098305] Dynamic subtest rcs0: SUCCESS (1.053s)
[394.112593] Starting dynamic subtest: bcs0
[395.155187] Dynamic subtest bcs0: SUCCESS (1.054s)
[395.170418] Starting dynamic subtest: vcs0
[396.208943] Dynamic subtest vcs0: SUCCESS (1.052s)
[396.225070] Starting dynamic subtest: vcs1
[397.262789] Dynamic subtest vcs1: SUCCESS (1.052s)
[397.277918] Starting dynamic subtest: vecs0
[398.314979] Dynamic subtest vecs0: SUCCESS (1.050s)
[398.331770] Starting dynamic subtest: ccs0
[399.373234] Dynamic subtest ccs0: SUCCESS (1.056s)
[399.375838] Subtest await: SUCCESS (7.453s)
[399.568993] [069/130] (725s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[399.675355] Starting subtest: bad-pixel-format-y-tiled-ccs
[399.677704] Starting dynamic subtest: pipe-A-eDP-1
[399.701139] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[399.711736] Starting dynamic subtest: pipe-B-eDP-1
[399.732467] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[399.741053] Starting dynamic subtest: pipe-C-eDP-1
[399.762660] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[399.771801] Starting dynamic subtest: pipe-D-eDP-1
[399.794805] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[399.799183] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.004s)
[401.785550] [070/130] (723s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[401.892824] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs
[401.895144] Starting dynamic subtest: pipe-A-eDP-1
[401.918200] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[401.927942] Starting dynamic subtest: pipe-B-eDP-1
[401.950140] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[401.958549] Starting dynamic subtest: pipe-C-eDP-1
[401.980579] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[401.988757] Starting dynamic subtest: pipe-D-eDP-1
[402.010943] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[402.014974] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[404.032803] [071/130] (720s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[404.136201] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[404.140353] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[404.219643] [072/130] (720s left) sw_sync (alloc_fence)
[404.256594] Starting subtest: alloc_fence
[404.258813] Subtest alloc_fence: SUCCESS (0.000s)
[404.301018] [073/130] (720s left) gem_exec_store (basic)
[404.372167] Starting subtest: basic
[404.489594] Subtest basic: SUCCESS (0.118s)
[404.667185] [074/130] (720s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[404.724003] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all
[404.796780] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.013s)
[404.844860] [075/130] (720s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[409.882997] Starting subtest: fbc-pr-overlay-plane-update-sf-dmg-area
[409.887766] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.002s)
[410.736189] [076/130] (714s left) sw_sync (alloc_timeline)
[410.774703] Starting subtest: alloc_timeline
[410.776969] Subtest alloc_timeline: SUCCESS (0.000s)
[410.829559] [077/130] (714s left) kms_cursor_legacy (forked-bo)
[410.951184] Starting subtest: forked-bo
[410.953527] Starting dynamic subtest: pipe-A
[416.441909] Dynamic subtest pipe-A: SUCCESS (5.486s)
[416.455556] Starting dynamic subtest: pipe-B
[421.938604] Dynamic subtest pipe-B: SUCCESS (5.492s)
[421.948412] Starting dynamic subtest: pipe-C
[427.457871] Dynamic subtest pipe-C: SUCCESS (5.515s)
[427.469405] Starting dynamic subtest: pipe-D
[432.960584] Dynamic subtest pipe-D: SUCCESS (5.498s)
[432.969293] Starting dynamic subtest: all-pipes
[438.534750] Dynamic subtest all-pipes: SUCCESS (5.569s)
[438.537080] Subtest forked-bo: SUCCESS (27.569s)
[438.657114] [078/130] (686s left) gen3_render_mixed_blits
[438.784725] [079/130] (686s left) gem_exec_schedule (pi-distinct-iova)
[438.977585] Starting subtest: pi-distinct-iova
[438.980113] Starting dynamic subtest: rcs0
[439.047753] Dynamic subtest rcs0: SUCCESS (0.072s)
[439.061051] Starting dynamic subtest: vcs0
[439.096400] Dynamic subtest vcs0: SUCCESS (0.049s)
[439.111300] Starting dynamic subtest: vcs1
[439.147087] Dynamic subtest vcs1: SUCCESS (0.050s)
[439.155522] Starting dynamic subtest: vecs0
[439.204459] Dynamic subtest vecs0: SUCCESS (0.056s)
[439.212996] Starting dynamic subtest: ccs0
[439.274128] Dynamic subtest ccs0: SUCCESS (0.068s)
[439.276514] Subtest pi-distinct-iova: SUCCESS (0.299s)
[440.765351] [080/130] (684s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-wc)
[440.872367] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-wc
[443.892739] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-wc: SUCCESS (3.023s)
[444.023826] [081/130] (681s left) gem_softpin (32b-excludes-last-page)
[444.088105] Starting subtest: 32b-excludes-last-page
[444.092946] Subtest 32b-excludes-last-page: SUCCESS (0.005s)
[444.215664] [082/130] (681s left) perf_pmu (invalid-open)
[444.255939] Starting subtest: invalid-open
[444.257657] Subtest invalid-open: SUCCESS (0.000s)
[444.365089] [083/130] (680s left) gem_pxp (display-protected-crc)
[444.486952] Starting subtest: display-protected-crc
[446.105870] Subtest display-protected-crc: SUCCESS (1.620s)
[446.228448] [084/130] (679s left) gem_ctx_engines (invalid-engines)
[446.296547] Starting subtest: invalid-engines
[446.303668] Subtest invalid-engines: SUCCESS (0.007s)
[446.554025] [085/130] (678s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[446.621100] Starting subtest: multi-wait-for-submit-available-signaled
[446.623543] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.000s)
[446.731237] [086/130] (678s left) gem_exec_balancer (invalid-bonds)
[446.799033] Starting subtest: invalid-bonds
[446.804375] Subtest invalid-bonds: SKIP (0.000s)
[447.087390] [087/130] (678s left) gem_huc_copy (huc-copy)
[447.140400] Starting subtest: huc-copy
[447.145293] Subtest huc-copy: SUCCESS (0.003s)
[447.271575] [088/130] (678s left) api_intel_allocator (fork-simple-stress-signal)
[447.333376] Starting subtest: fork-simple-stress-signal
[452.738180] Subtest fork-simple-stress-signal: SUCCESS (5.411s)
[452.857576] [089/130] (672s left) kms_content_protection (srm)
[453.030650] Starting subtest: srm
[456.403508] Subtest srm: SKIP (3.372s)
[457.571370] [090/130] (668s left) kms_prop_blob (blob-prop-lifetime)
[457.627966] Starting subtest: blob-prop-lifetime
[457.629879] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[457.723851] [091/130] (667s left) gem_mmap_gtt (big-bo-tiledy)
[457.783953] Subtest big-bo-tiledY: SKIP (0.000s)
[457.829548] [092/130] (667s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[457.929736] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[457.933821] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[458.037835] [093/130] (667s left) kms_psr (psr2-dpms)
[458.135878] Starting subtest: psr2-dpms
[458.138141] Starting dynamic subtest: eDP-1
[460.978667] Dynamic subtest eDP-1: SUCCESS (2.847s)
[460.981034] Subtest psr2-dpms: SUCCESS (2.848s)
[461.827619] [094/130] (663s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[461.883351] Starting subtest: multi-wait-all-for-submit-signaled
[461.885469] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s)
[461.986311] [095/130] (663s left) gem_mmap_wc (read-write-distinct)
[462.050391] Subtest read-write-distinct: SKIP (0.000s)
[462.109312] [096/130] (663s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[462.167439] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[462.269983] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.103s)
[462.342183] [097/130] (663s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[462.400249] Starting subtest: yf-tiled-ccs-to-y-tiled
[462.404833] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s)
[462.575201] [098/130] (663s left) kms_big_fb (linear-8bpp-rotate-270)
[462.679650] Starting subtest: linear-8bpp-rotate-270
[462.699334] Subtest linear-8bpp-rotate-270: SKIP (0.019s)
[462.818676] [099/130] (663s left) kms_psr (fbc-psr2-primary-page-flip)
[462.916930] Starting subtest: fbc-psr2-primary-page-flip
[462.919179] Starting dynamic subtest: eDP-1
[462.923692] Dynamic subtest eDP-1: SKIP (0.000s)
[462.928185] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[462.985873] [100/130] (662s left) kms_addfb_basic (unused-handle)
[463.040260] Starting subtest: unused-handle
[463.042465] Subtest unused-handle: SUCCESS (0.000s)
[463.189861] [101/130] (662s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[463.296800] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[463.301247] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[463.389586] [102/130] (662s left) sw_sync (sync_expired_merge)
[463.427163] Starting subtest: sync_expired_merge
[464.498371] Subtest sync_expired_merge: SUCCESS (1.074s)
[464.553175] [103/130] (661s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[464.619185] Starting subtest: single-wait-for-submit-unsubmitted
[464.725988] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.105s)
[464.794798] [104/130] (661s left) gem_ctx_persistence (heartbeat-hang)
[464.853975] Starting subtest: heartbeat-hang
[464.858861] Subtest heartbeat-hang: SKIP (0.000s)
[464.966090] [105/130] (661s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[465.357494] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[466.124036] [106/130] (660s left) kms_psr (psr-primary-blt)
[466.228535] Starting subtest: psr-primary-blt
[466.230832] Starting dynamic subtest: eDP-1
[467.934829] Dynamic subtest eDP-1: SUCCESS (1.709s)
[467.937066] Subtest psr-primary-blt: SUCCESS (1.709s)
[468.796230] [107/130] (657s left) perf (non-zero-reason)
[468.897250] Starting subtest: non-zero-reason
[468.899507] Starting dynamic subtest: 0-rcs0
[474.302513] Dynamic subtest 0-rcs0: SUCCESS (5.406s)
[474.313651] Starting dynamic subtest: 1-vecs0
[478.245425] Dynamic subtest 1-vecs0: SUCCESS (3.943s)
[478.247942] Subtest non-zero-reason: SUCCESS (9.351s)
[478.286586] [108/130] (647s left) gem_ccs (block-multicopy-inplace)
[478.355853] Starting subtest: block-multicopy-inplace
[478.360589] Subtest block-multicopy-inplace: SKIP (0.000s)
[478.465254] [109/130] (647s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[478.564016] Starting subtest: plane-all-transition-nonblocking-fencing
[478.566377] Starting dynamic subtest: pipe-A-eDP-1
[481.070375] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.504s)
[481.363493] Starting dynamic subtest: pipe-B-eDP-1
[484.620613] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.271s)
[484.894008] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.331s)
[485.730856] [110/130] (640s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[485.840683] Starting subtest: psr-rgb101010-draw-mmap-gtt
[485.845107] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[485.943264] [111/130] (640s left) kms_async_flips (invalid-async-flip)
[486.044001] Starting subtest: invalid-async-flip
[486.047863] Subtest invalid-async-flip: SKIP (0.000s)
[487.254821] [112/130] (639s left) syncobj_wait (wait-any-interrupted)
[487.305467] Starting subtest: wait-any-interrupted
[487.408985] Subtest wait-any-interrupted: SUCCESS (0.102s)
[487.483570] [113/130] (638s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[487.595033] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[487.599416] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[487.691567] [114/130] (638s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[487.794346] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[492.311333] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (4.522s)
[492.441765] [115/130] (634s left) syncobj_wait (wait-for-submit-delayed-submit)
[492.502270] Starting subtest: wait-for-submit-delayed-submit
[492.605799] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[492.676482] [116/130] (633s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[492.739321] Starting subtest: invalid-multi-wait-unsubmitted
[492.741773] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[492.845334] [117/130] (633s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[492.957040] Starting subtest: fbc-rgb101010-draw-mmap-wc
[496.471159] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (3.517s)
[496.581191] [118/130] (629s left) gem_ctx_bad_destroy (invalid-pad)
[496.637268] Starting subtest: invalid-pad
[496.639847] Subtest invalid-pad: SUCCESS (0.000s)
[496.703023] [119/130] (629s left) gem_mmap_gtt (cpuset-big-copy)
[496.771432] Subtest cpuset-big-copy: SKIP (0.000s)
[496.829282] [120/130] (629s left) kms_cursor_crc (cursor-size-change)
[496.928890] Starting subtest: cursor-size-change
[496.931153] Starting dynamic subtest: pipe-A-eDP-1
[497.748113] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.818s)
[497.757972] Starting dynamic subtest: pipe-D-eDP-1
[499.198589] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.448s)
[499.200959] Subtest cursor-size-change: SUCCESS (2.268s)
[500.065883] [121/130] (626s left) gem_exec_flush (basic-batch-kernel-default-uc)
[500.134103] Starting subtest: basic-batch-kernel-default-uc
[507.129939] Subtest basic-batch-kernel-default-uc: SUCCESS (6.996s)
[507.319591] [122/130] (619s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff)
[507.432387] Starting subtest: psr-2p-primscrn-spr-indfb-onoff
[507.436805] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[507.518094] [123/130] (619s left) i915_pm_rpm (gem-evict-pwrite)
[509.858248] Starting subtest: gem-evict-pwrite
[509.864342] Subtest gem-evict-pwrite: SKIP (0.000s)
[510.206666] [124/130] (616s left) gem_ctx_persistence (legacy-engines-mixed-process)
[510.275973] Starting subtest: legacy-engines-mixed-process
[510.278440] Starting dynamic subtest: render
[511.642364] Dynamic subtest render: SUCCESS (1.366s)
[511.653527] Starting dynamic subtest: bsd1
[513.630493] Dynamic subtest bsd1: SUCCESS (1.986s)
[513.641558] Starting dynamic subtest: bsd2
[515.687413] Dynamic subtest bsd2: SUCCESS (2.054s)
[515.698799] Starting dynamic subtest: blt
[517.657163] Dynamic subtest blt: SUCCESS (1.967s)
[517.666580] Starting dynamic subtest: vebox
[519.664399] Dynamic subtest vebox: SUCCESS (2.005s)
[519.666901] Subtest legacy-engines-mixed-process: SUCCESS (9.388s)
[519.738743] [125/130] (607s left) i915_query (query-regions-unallocated)
[519.796133] Starting subtest: query-regions-unallocated
[519.798316] Subtest query-regions-unallocated: SUCCESS (0.000s)
[519.905302] [126/130] (606s left) perf (gen8-unprivileged-single-ctx-counters)
[519.990417] Starting subtest: gen8-unprivileged-single-ctx-counters
[519.994973] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[520.030121] [127/130] (606s left) kms_chamelium_color (ctm-0-25)
[520.131622] Subtest ctm-0-25: SKIP (0.000s)
[520.172547] [128/130] (606s left) gem_exec_reloc (basic-range)
[520.225390] Subtest basic-range: SKIP (0.000s)
[520.310347] [129/130] (606s left) syncobj_timeline (wait-for-submit-complex)
[520.372045] Starting subtest: wait-for-submit-complex
[520.431519] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[520.504006] [130/130] (606s left) gen9_exec_parse (bb-oversize)
[520.565908] Subtest bb-oversize: SKIP (0.000s)
[520.612190] Closing watchdogs
Done.