[61.102356] Initializing watchdogs
[61.102403]   /dev/watchdog0
[61.116047] [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]
[61.120409] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.122631] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.126121] [001/133] (960s left) gem_mmap_gtt (basic-read-write)
[61.204333] Subtest basic-read-write: SKIP (0.000s)
[61.256106] [002/133] (960s left) kms_plane (pixel-format-linear-modifier)
[61.354071] Starting subtest: pixel-format-linear-modifier
[61.393124] Starting dynamic subtest: pipe-A-plane-0
[64.865976] Dynamic subtest pipe-A-plane-0: SUCCESS (3.456s)
[64.873843] Starting dynamic subtest: pipe-A-plane-3
[66.538355] Dynamic subtest pipe-A-plane-3: SUCCESS (1.666s)
[66.546133] Starting dynamic subtest: pipe-A-plane-5
[66.750049] Dynamic subtest pipe-A-plane-5: SUCCESS (0.211s)
[67.916045] Starting dynamic subtest: pipe-B-plane-0
[71.416400] Dynamic subtest pipe-B-plane-0: SUCCESS (3.500s)
[71.423191] Starting dynamic subtest: pipe-B-plane-3
[73.041473] Dynamic subtest pipe-B-plane-3: SUCCESS (1.622s)
[73.049856] Starting dynamic subtest: pipe-B-plane-5
[73.252698] Dynamic subtest pipe-B-plane-5: SUCCESS (0.210s)
[73.573253] Subtest pixel-format-linear-modifier: SUCCESS (12.179s)
[74.398742] [003/133] (947s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[74.498993] Starting subtest: y-tiled-8bpp-rotate-270
[74.503118] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[74.601744] [004/133] (947s left) syncobj_wait (single-wait-for-submit-signaled)
[74.659188] Starting subtest: single-wait-for-submit-signaled
[74.661599] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[74.759910] [005/133] (947s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[74.874604] Starting subtest: flip-vs-cursor-atomic
[81.952822] Subtest flip-vs-cursor-atomic: SUCCESS (7.070s)
[82.747783] [006/133] (939s left) kms_chamelium_frames (hdmi-crc-fast)
[83.138375] Subtest hdmi-crc-fast: SKIP (0.000s)
[83.955698] [007/133] (937s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[84.067410] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[84.071456] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[84.168996] [008/133] (937s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[84.273251] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[84.277281] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[84.376264] [009/133] (937s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[84.489260] Starting subtest: fbc-rgb101010-draw-blt
[89.077191] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.587s)
[90.185428] [010/133] (931s left) kms_dp_linktrain_fallback (dsc-fallback)
[90.281360] Starting subtest: dsc-fallback
[90.288257] Subtest dsc-fallback: SKIP (0.000s)
[90.353439] [011/133] (931s left) gem_exec_balancer (fairslice)
[90.414311] Starting subtest: fairslice
[93.293873] Subtest fairslice: SUCCESS (2.875s)
[93.606665] [012/133] (928s left) gem_eio (in-flight-immediate)
[93.839707] Starting subtest: in-flight-immediate
[102.801051] Subtest in-flight-immediate: SUCCESS (8.959s)
[102.932109] [FACT gem_eio (in-flight-immediate)] new: kernel.kmod_is_loaded.vgem: true
[102.935564] [013/133] (919s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[102.993912] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[102.996224] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[103.090710] [014/133] (919s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[103.208197] Starting subtest: fbcpsr-2p-rte
[103.212324] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[103.305403] [015/133] (918s left) kms_psr (psr2-cursor-mmap-cpu)
[103.395523] Starting subtest: psr2-cursor-mmap-cpu
[103.397842] Starting dynamic subtest: eDP-1
[105.039918] Dynamic subtest eDP-1: SUCCESS (1.644s)
[105.042421] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.645s)
[105.838111] [016/133] (916s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[105.947861] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[112.533058] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.585s)
[112.692092] [017/133] (909s left) sw_sync (sync_multi_consumer_producer)
[112.732068] Starting subtest: sync_multi_consumer_producer
[113.011936] Subtest sync_multi_consumer_producer: SUCCESS (0.280s)
[113.070271] [018/133] (909s left) kms_setmode (basic)
[113.120058] Starting subtest: basic
[113.440940] Starting dynamic subtest: pipe-A-eDP-1
[115.583230] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.137s)
[115.927042] Starting dynamic subtest: pipe-B-eDP-1
[118.024986] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.103s)
[118.349524] Subtest basic: SUCCESS (5.228s)
[119.172093] [019/133] (903s left) kms_psr (fbc-psr-primary-render)
[119.269068] Starting subtest: fbc-psr-primary-render
[119.271396] Starting dynamic subtest: eDP-1
[119.275783] Dynamic subtest eDP-1: SKIP (0.000s)
[119.280128] Subtest fbc-psr-primary-render: SKIP (0.001s)
[119.341320] [020/133] (903s left) kms_psr (psr-cursor-plane-move)
[119.436218] Starting subtest: psr-cursor-plane-move
[119.438570] Starting dynamic subtest: eDP-1
[121.166551] Dynamic subtest eDP-1: SUCCESS (1.730s)
[121.169017] Subtest psr-cursor-plane-move: SUCCESS (1.731s)
[122.028393] [021/133] (900s left) kms_pipe_crc_basic (suspend-read-crc)
[122.126117] Starting subtest: suspend-read-crc
[122.128306] Starting dynamic subtest: pipe-A-eDP-1
[139.141901] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.690s)
[139.150778] Starting dynamic subtest: pipe-B-eDP-1
[157.147196] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.093s)
[157.157308] Starting dynamic subtest: pipe-C-eDP-1
[175.132214] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.036s)
[175.140875] Starting dynamic subtest: pipe-D-eDP-1
[193.112506] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.050s)
[193.115080] Subtest suspend-read-crc: SUCCESS (11.874s)
[193.988819] [022/133] (828s left) kms_flip (flip-vs-dpms-on-nop)
[194.099552] Starting subtest: flip-vs-dpms-on-nop
[194.101964] Starting dynamic subtest: A-eDP1
[196.024215] Dynamic subtest A-eDP1: SUCCESS (1.862s)
[196.040244] Starting dynamic subtest: B-eDP1
[197.911026] Dynamic subtest B-eDP1: SUCCESS (1.834s)
[197.922256] Starting dynamic subtest: C-eDP1
[199.788986] Dynamic subtest C-eDP1: SUCCESS (1.838s)
[199.798805] Starting dynamic subtest: D-eDP1
[201.659303] Dynamic subtest D-eDP1: SUCCESS (1.838s)
[201.664035] Subtest flip-vs-dpms-on-nop: SUCCESS (7.384s)
[202.853480] [023/133] (819s left) gem_bad_reloc (negative-reloc-bltcopy)
[202.921832] Subtest negative-reloc-bltcopy: SKIP (0.000s)
[202.990068] [024/133] (819s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[203.046771] Starting subtest: invalid-single-wait-all-unsubmitted
[203.049101] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[203.167671] [025/133] (819s left) gem_ccs (block-multicopy-compressed)
[203.235700] Starting subtest: block-multicopy-compressed
[203.240334] Subtest block-multicopy-compressed: SKIP (0.000s)
[203.357221] [026/133] (819s left) gen9_exec_parse (unaligned-jump)
[203.406501] Subtest unaligned-jump: SKIP (0.000s)
[203.488561] [027/133] (819s left) perf_pmu (multi-client)
[203.528819] Starting subtest: multi-client
[203.530705] Starting dynamic subtest: rcs0
[204.599954] Dynamic subtest rcs0: SUCCESS (1.059s)
[204.611312] Starting dynamic subtest: bcs0
[205.659412] Dynamic subtest bcs0: SUCCESS (1.047s)
[205.671041] Starting dynamic subtest: vcs0
[206.720828] Dynamic subtest vcs0: SUCCESS (1.050s)
[206.732262] Starting dynamic subtest: vcs1
[208.638481] Dynamic subtest vcs1: SUCCESS (1.902s)
[208.649948] Starting dynamic subtest: vecs0
[210.684066] Dynamic subtest vecs0: SUCCESS (2.033s)
[210.695403] Starting dynamic subtest: ccs0
[212.667749] Dynamic subtest ccs0: SUCCESS (1.974s)
[212.670553] Subtest multi-client: SUCCESS (9.078s)
[212.792483] [028/133] (809s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[212.901178] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[217.071315] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.161s)
[218.246881] [029/133] (804s left) gem_exec_schedule (fairslice-all)
[218.317812] Starting subtest: fairslice-all
[220.368585] Subtest fairslice-all: SUCCESS (2.048s)
[220.672815] [030/133] (802s left) kms_joiner (basic-max-non-joiner)
[220.768125] Starting subtest: basic-max-non-joiner
[220.772103] Subtest basic-max-non-joiner: SKIP (0.000s)
[220.836266] [031/133] (801s left) prime_vgem (coherency-gtt)
[220.910060] Starting subtest: coherency-gtt
[220.914753] Subtest coherency-gtt: SKIP (0.000s)
[221.022925] [032/133] (801s left) gem_exec_create (madvise)
[221.098002] Starting subtest: madvise
[221.100399] Starting dynamic subtest: smem
[241.255416] Dynamic subtest smem: SUCCESS (20.151s)
[241.257982] Subtest madvise: SUCCESS (20.151s)
[242.209771] [033/133] (780s left) gem_exec_fence (syncobj-repeat)
[242.716599] Starting subtest: syncobj-repeat
[242.902319] Subtest syncobj-repeat: SUCCESS (0.184s)
[244.691843] [034/133] (778s left) api_intel_bb (blit-noreloc-keep-cache)
[244.747949] Starting subtest: blit-noreloc-keep-cache
[244.764211] Subtest blit-noreloc-keep-cache: SUCCESS (0.019s)
[244.884452] [035/133] (778s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[244.944959] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[245.024252] [036/133] (778s left) gem_workarounds (basic-read)
[245.092128] Starting subtest: basic-read
[245.109324] Subtest basic-read: SUCCESS (0.018s)
[245.228731] [037/133] (777s left) prime_mmap (test_correct_cpu_write)
[245.278907] Starting subtest: test_correct_cpu_write
[245.281281] Starting dynamic subtest: test_correct_cpu_write-smem
[245.283244] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[245.285212] Subtest test_correct_cpu_write: SUCCESS (0.001s)
[245.362707] [038/133] (777s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[245.455526] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[245.457793] Starting dynamic subtest: pipe-A-eDP-1
[245.480184] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[245.490773] Starting dynamic subtest: pipe-B-eDP-1
[245.514131] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[245.522888] Starting dynamic subtest: pipe-C-eDP-1
[245.545089] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[245.553965] Starting dynamic subtest: pipe-D-eDP-1
[245.578154] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[245.582477] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.004s)
[247.699037] [039/133] (775s left) gen9_exec_parse (bb-oversize)
[247.758060] Subtest bb-oversize: SKIP (0.000s)
[247.819118] [040/133] (775s left) gem_exec_schedule (pi-userfault)
[247.999919] Starting subtest: pi-userfault
[248.002187] Starting dynamic subtest: rcs0
[248.007871] Dynamic subtest rcs0: SUCCESS (0.011s)
[248.017682] Starting dynamic subtest: bcs0
[248.020029] Dynamic subtest bcs0: SUCCESS (0.010s)
[248.028017] Starting dynamic subtest: vcs0
[248.030399] Dynamic subtest vcs0: SUCCESS (0.010s)
[248.038565] Starting dynamic subtest: vcs1
[248.040878] Dynamic subtest vcs1: SUCCESS (0.010s)
[248.049282] Starting dynamic subtest: vecs0
[248.051594] Dynamic subtest vecs0: SUCCESS (0.007s)
[248.059880] Starting dynamic subtest: ccs0
[248.061845] Dynamic subtest ccs0: SUCCESS (0.008s)
[248.063925] Subtest pi-userfault: SUCCESS (0.059s)
[248.239074] [041/133] (775s left) kms_dsc (dsc-with-bpc)
[248.342897] Starting subtest: dsc-with-bpc
[248.374563] Subtest dsc-with-bpc: SKIP (0.001s)
[248.414072] [042/133] (774s left) kms_cursor_crc (cursor-offscreen-512x512)
[248.678505] Starting subtest: cursor-offscreen-512x512
[248.682543] Subtest cursor-offscreen-512x512: SKIP (0.002s)
[248.860167] [043/133] (774s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[248.964421] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[248.968889] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[249.027045] [044/133] (774s left) vgem_basic (bad-fence)
[249.072280] Starting subtest: bad-fence
[249.074244] Subtest bad-fence: SUCCESS (0.000s)
[249.137372] [045/133] (774s left) gem_render_copy (yf-tiled-to-vebox-linear)
[249.198970] Starting subtest: yf-tiled-to-vebox-linear
[249.202671] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[249.383153] [046/133] (774s left) gem_eio (in-flight-internal-immediate)
[249.604665] Starting subtest: in-flight-internal-immediate
[250.698071] Subtest in-flight-internal-immediate: SUCCESS (1.092s)
[250.847685] [047/133] (772s left) kms_flip (blocking-absolute-wf_vblank)
[250.941911] Starting subtest: blocking-absolute-wf_vblank
[250.944275] Starting dynamic subtest: A-eDP1
[259.649429] Dynamic subtest A-eDP1: SUCCESS (8.703s)
[259.665448] Starting dynamic subtest: B-eDP1
[268.385734] Dynamic subtest B-eDP1: SUCCESS (8.730s)
[268.395941] Starting dynamic subtest: C-eDP1
[277.101619] Dynamic subtest C-eDP1: SUCCESS (8.710s)
[277.112166] Starting dynamic subtest: D-eDP1
[285.834355] Dynamic subtest D-eDP1: SUCCESS (8.726s)
[285.839947] Subtest blocking-absolute-wf_vblank: SUCCESS (34.884s)
[287.054085] [048/133] (736s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs)
[287.152977] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs
[287.155379] Starting dynamic subtest: pipe-A-eDP-1
[287.179258] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[287.190645] Starting dynamic subtest: pipe-B-eDP-1
[287.212924] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[287.221384] Starting dynamic subtest: pipe-C-eDP-1
[287.243176] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[287.251525] Starting dynamic subtest: pipe-D-eDP-1
[287.273618] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[287.277715] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[289.324969] [049/133] (734s left) kms_properties (connector-properties-legacy)
[289.412746] Starting subtest: connector-properties-legacy
[289.414964] Starting dynamic subtest: pipe-A-eDP-1
[297.300912] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.892s)
[297.311044] Starting dynamic subtest: pipe-None-DP-1
[297.315741] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[297.323916] Starting dynamic subtest: pipe-None-HDMI-A-1
[297.328238] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[297.336437] Starting dynamic subtest: pipe-None-DP-2
[297.340950] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[297.349356] Starting dynamic subtest: pipe-None-HDMI-A-2
[297.354064] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[297.362534] Starting dynamic subtest: pipe-None-DP-3
[297.367255] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[297.375534] Starting dynamic subtest: pipe-None-DP-4
[297.379756] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[297.381679] Subtest connector-properties-legacy: SUCCESS (7.903s)
[298.170031] [050/133] (725s left) perf_pmu (busy-hang)
[298.212112] Starting subtest: busy-hang
[298.214581] Starting dynamic subtest: rcs0
[299.475436] Dynamic subtest rcs0: SUCCESS (1.262s)
[299.486124] Starting dynamic subtest: bcs0
[300.710810] Dynamic subtest bcs0: SUCCESS (1.237s)
[300.719754] Starting dynamic subtest: vcs0
[303.174123] Dynamic subtest vcs0: SUCCESS (2.462s)
[303.185419] Starting dynamic subtest: vcs1
[305.149272] Dynamic subtest vcs1: SUCCESS (1.970s)
[305.159765] Starting dynamic subtest: vecs0
[307.138930] Dynamic subtest vecs0: SUCCESS (1.992s)
[307.150517] Starting dynamic subtest: ccs0
[308.449494] Dynamic subtest ccs0: SUCCESS (1.305s)
[308.451976] Subtest busy-hang: SUCCESS (10.239s)
[308.555126] [051/133] (715s left) kms_vblank (ts-continuation-modeset-rpm)
[308.651748] Starting subtest: ts-continuation-modeset-rpm
[308.653782] Starting dynamic subtest: pipe-A-eDP-1
[311.167410] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.516s)
[311.182894] Starting dynamic subtest: pipe-D-eDP-1
[313.395076] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.219s)
[313.397274] Subtest ts-continuation-modeset-rpm: SUCCESS (4.743s)
[314.283740] [052/133] (709s left) syncobj_wait (single-wait-for-submit-submitted)
[314.352450] Starting subtest: single-wait-for-submit-submitted
[314.460461] Subtest single-wait-for-submit-submitted: SUCCESS (0.105s)
[314.539865] [053/133] (709s left) kms_universal_plane (cursor-fb-leak)
[314.637969] Starting subtest: cursor-fb-leak
[314.640336] Starting dynamic subtest: pipe-A-eDP-1
[314.982659] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.346s)
[314.994547] Starting dynamic subtest: pipe-B-eDP-1
[316.411398] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.426s)
[316.426918] Starting dynamic subtest: pipe-C-eDP-1
[317.816939] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.402s)
[317.828012] Starting dynamic subtest: pipe-D-eDP-1
[319.144062] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.326s)
[319.146342] Subtest cursor-fb-leak: SUCCESS (4.509s)
[320.296041] [054/133] (703s left) gem_exec_schedule (smoketest)
[320.478455] Starting subtest: smoketest
[320.480991] Starting dynamic subtest: rcs0
[326.018243] Dynamic subtest rcs0: SUCCESS (5.492s)
[326.034907] Starting dynamic subtest: bcs0
[331.539947] Dynamic subtest bcs0: SUCCESS (5.511s)
[331.559529] Starting dynamic subtest: vcs0
[337.045510] Dynamic subtest vcs0: SUCCESS (5.510s)
[337.058497] Starting dynamic subtest: vcs1
[342.543824] Dynamic subtest vcs1: SUCCESS (5.493s)
[342.556174] Starting dynamic subtest: vecs0
[348.058106] Dynamic subtest vecs0: SUCCESS (5.518s)
[348.074788] Starting dynamic subtest: ccs0
[353.564869] Dynamic subtest ccs0: SUCCESS (5.502s)
[353.567028] Subtest smoketest: SUCCESS (33.034s)
[353.724448] [055/133] (670s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[353.827918] Starting subtest: x-tiled-addfb-size-offset-overflow
[353.829782] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[353.918391] [056/133] (669s left) kms_atomic_transition (plane-all-transition-nonblocking)
[354.017502] Starting subtest: plane-all-transition-nonblocking
[354.019867] Starting dynamic subtest: pipe-A-eDP-1
[356.511296] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[356.833536] Starting dynamic subtest: pipe-B-eDP-1
[360.041694] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.220s)
[360.350751] Subtest plane-all-transition-nonblocking: SUCCESS (6.334s)
[361.162092] [057/133] (662s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[361.229397] Starting subtest: single-wait-for-submit-unsubmitted
[361.341252] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.109s)
[361.428651] [058/133] (662s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[361.522655] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[361.526843] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[361.621226] [059/133] (662s left) kms_flip (absolute-wf_vblank)
[361.719774] Starting subtest: absolute-wf_vblank
[361.722063] Starting dynamic subtest: A-eDP1
[370.422025] Dynamic subtest A-eDP1: SUCCESS (8.699s)
[370.433893] Starting dynamic subtest: B-eDP1
[379.170221] Dynamic subtest B-eDP1: SUCCESS (8.733s)
[379.183533] Starting dynamic subtest: C-eDP1
[387.887884] Dynamic subtest C-eDP1: SUCCESS (8.722s)
[387.898472] Starting dynamic subtest: D-eDP1
[396.627089] Dynamic subtest D-eDP1: SUCCESS (8.735s)
[396.629389] Subtest absolute-wf_vblank: SUCCESS (34.901s)
[397.843500] [060/133] (626s left) gem_ctx_persistence (heartbeat-hostile)
[397.922392] Starting subtest: heartbeat-hostile
[397.926968] Subtest heartbeat-hostile: SKIP (0.000s)
[398.037034] [061/133] (626s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[398.090777] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[398.196125] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.104s)
[398.284891] [062/133] (625s left) gem_exec_params (dr1-dirt)
[398.336107] Starting subtest: DR1-dirt
[398.338497] Subtest DR1-dirt: SUCCESS (0.000s)
[398.435347] [063/133] (625s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[398.539004] Starting subtest: addfb25-yf-tiled-legacy
[398.541203] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[398.621733] [064/133] (625s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[398.718092] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[398.720395] Starting dynamic subtest: pipe-A-eDP-1
[398.743180] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[398.756731] Starting dynamic subtest: pipe-B-eDP-1
[398.778171] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[398.786846] Starting dynamic subtest: pipe-C-eDP-1
[398.808382] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[398.816854] Starting dynamic subtest: pipe-D-eDP-1
[398.838363] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[398.842408] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[401.000053] [065/133] (623s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[401.057738] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[401.060073] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[401.151356] [066/133] (623s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[401.231723] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[401.235756] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[401.303285] [067/133] (623s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[401.521980] Starting subtest: cursor-rapid-movement-128x128
[401.526752] Starting dynamic subtest: pipe-A-eDP-1
[402.068156] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.543s)
[402.098454] Starting dynamic subtest: pipe-D-eDP-1
[403.329138] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.238s)
[403.331314] Subtest cursor-rapid-movement-128x128: SUCCESS (1.806s)
[404.171506] [068/133] (620s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[404.268058] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[404.272774] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[404.373619] [069/133] (620s left) i915_hangman (detector)
[404.434381] Starting subtest: detector
[404.436460] Starting dynamic subtest: rcs0
[415.582199] Dynamic subtest rcs0: SUCCESS (11.145s)
[415.594429] Starting dynamic subtest: bcs0
[427.549917] Dynamic subtest bcs0: SUCCESS (11.967s)
[427.562246] Starting dynamic subtest: vcs0
[438.558545] Dynamic subtest vcs0: SUCCESS (11.007s)
[438.571685] Starting dynamic subtest: vcs1
[450.590178] Dynamic subtest vcs1: SUCCESS (12.029s)
[450.602431] Starting dynamic subtest: vecs0
[462.558143] Dynamic subtest vecs0: SUCCESS (11.965s)
[462.575351] Starting dynamic subtest: ccs0
[473.630278] Dynamic subtest ccs0: SUCCESS (11.069s)
[473.633372] Subtest detector: SUCCESS (69.199s)
[473.782039] [070/133] (550s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[473.882300] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[480.901302] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.021s)
[481.013462] [071/133] (543s left) core_auth (getclient-simple)
[481.063223] Starting subtest: getclient-simple
[481.074819] Subtest getclient-simple: SUCCESS (0.011s)
[481.169985] [072/133] (543s left) kms_properties (colorop-properties-legacy)
[481.254766] Starting subtest: colorop-properties-legacy
[481.256954] Starting dynamic subtest: pipe-A-eDP-1
[481.611270] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.356s)
[481.620418] Starting dynamic subtest: pipe-B-eDP-1
[482.642271] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.030s)
[482.654933] Starting dynamic subtest: pipe-C-eDP-1
[483.685185] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.042s)
[483.694317] Starting dynamic subtest: pipe-D-eDP-1
[484.722391] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.034s)
[484.724800] Subtest colorop-properties-legacy: SUCCESS (3.468s)
[485.519749] [073/133] (539s left) gem_ctx_param (invalid-get-engines)
[485.582594] Starting subtest: invalid-get-engines
[485.584997] Subtest invalid-get-engines: SUCCESS (0.001s)
[485.686842] [074/133] (538s left) kms_prop_blob (basic)
[485.749785] Starting subtest: basic
[485.751958] Subtest basic: SUCCESS (0.000s)
[485.863842] [075/133] (538s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[485.989530] Starting subtest: cursorB-vs-flipA-toggle
[485.994246] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[486.132899] [076/133] (538s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[486.229117] Starting subtest: plane-scaler-unity-scaling-with-rotation
[486.231413] Starting dynamic subtest: pipe-A
[486.466464] Dynamic subtest pipe-A: SUCCESS (0.240s)
[486.475446] Starting dynamic subtest: pipe-B
[487.804481] Dynamic subtest pipe-B: SUCCESS (1.336s)
[487.820638] Starting dynamic subtest: pipe-C
[489.157127] Dynamic subtest pipe-C: SUCCESS (1.350s)
[489.166053] Starting dynamic subtest: pipe-D
[490.462023] Dynamic subtest pipe-D: SUCCESS (1.304s)
[490.464308] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.236s)
[491.648306] [077/133] (533s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[491.745533] Starting subtest: extended-modeset-hang-oldfb-with-reset
[491.748073] Starting dynamic subtest: pipe-A
[503.909286] Dynamic subtest pipe-A: SUCCESS (12.161s)
[503.919430] Starting dynamic subtest: pipe-D
[516.387335] Dynamic subtest pipe-D: SUCCESS (12.474s)
[516.389858] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.639s)
[517.192095] [078/133] (507s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[517.301532] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[517.305895] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[517.407880] [079/133] (507s left) kms_plane_scaling (planes-upscale-20x20)
[517.495061] Starting subtest: planes-upscale-20x20
[517.497467] Starting dynamic subtest: pipe-A
[517.557205] Dynamic subtest pipe-A: SUCCESS (0.062s)
[517.567459] Starting dynamic subtest: pipe-B
[518.708663] Dynamic subtest pipe-B: SUCCESS (1.150s)
[518.720010] Starting dynamic subtest: pipe-C
[519.824038] Dynamic subtest pipe-C: SUCCESS (1.114s)
[519.836756] Starting dynamic subtest: pipe-D
[520.951589] Dynamic subtest pipe-D: SUCCESS (1.126s)
[520.953903] Subtest planes-upscale-20x20: SUCCESS (3.457s)
[522.106077] [080/133] (502s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[522.193975] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[522.195874] Starting dynamic subtest: pipe-A-eDP-1
[522.919310] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.719s)
[522.928258] Starting dynamic subtest: pipe-B-eDP-1
[524.705523] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.784s)
[524.715595] Starting dynamic subtest: pipe-C-eDP-1
[526.449859] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.743s)
[526.459413] Starting dynamic subtest: pipe-D-eDP-1
[528.173750] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.723s)
[528.176097] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (5.973s)
[529.341687] [081/133] (495s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[529.435472] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[529.439674] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[529.532164] [082/133] (495s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[529.915113] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[530.744146] [083/133] (494s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[530.834739] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[530.839156] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[530.941045] [084/133] (494s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[531.050859] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[531.053094] Starting dynamic subtest: A-eDP1
[534.597222] Dynamic subtest A-eDP1: SUCCESS (3.541s)
[534.607537] Starting dynamic subtest: B-eDP1
[537.797513] Dynamic subtest B-eDP1: SUCCESS (3.200s)
[537.807411] Starting dynamic subtest: C-eDP1
[540.879443] Dynamic subtest C-eDP1: SUCCESS (3.081s)
[540.889534] Starting dynamic subtest: D-eDP1
[543.981261] Dynamic subtest D-eDP1: SUCCESS (3.100s)
[543.983494] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (12.931s)
[544.783001] [085/133] (480s left) gem_mmap_gtt (basic-read)
[544.839905] Subtest basic-read: SKIP (0.000s)
[544.909234] [086/133] (480s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[544.966744] Starting subtest: single-wait-for-submit-available-signaled
[544.969110] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[545.078658] [087/133] (480s left) gem_vm_create (isolation)
[545.135563] Starting subtest: isolation
[545.144422] Subtest isolation: SUCCESS (0.009s)
[545.280198] [088/133] (479s left) gem_mmap_gtt (hang-busy)
[545.333618] Subtest hang-busy: SKIP (0.000s)
[545.396485] [089/133] (479s left) kms_lease (lease-uevent)
[545.482965] Starting subtest: lease-uevent
[546.491027] Subtest lease-uevent: SUCCESS (1.009s)
[546.566048] [090/133] (478s left) gem_mmap_gtt (basic-short)
[546.626597] Subtest basic-short: SKIP (0.000s)
[546.687194] [091/133] (478s left) gem_mmap_gtt (cpuset-big-copy-xy)
[546.742450] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[546.799593] [092/133] (478s left) kms_scaling_modes (scaling-mode-full)
[546.878878] Starting subtest: scaling-mode-full
[546.880825] Starting dynamic subtest: pipe-A-eDP-1
[546.971139] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.093s)
[546.983049] Starting dynamic subtest: pipe-B-eDP-1
[548.114946] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.142s)
[548.126517] Starting dynamic subtest: pipe-C-eDP-1
[549.228772] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.112s)
[549.240167] Starting dynamic subtest: pipe-D-eDP-1
[550.364972] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.134s)
[550.367313] Subtest scaling-mode-full: SUCCESS (3.488s)
[551.517586] [093/133] (473s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[551.642221] Starting subtest: basic-flip-after-cursor-legacy
[552.566505] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.923s)
[553.451479] [094/133] (471s left) kms_flip (nonexisting-fb)
[553.542933] Starting subtest: nonexisting-fb
[553.545334] Starting dynamic subtest: A-eDP1
[554.732778] Dynamic subtest A-eDP1: SUCCESS (1.189s)
[554.745806] Starting dynamic subtest: B-eDP1
[555.855321] Dynamic subtest B-eDP1: SUCCESS (1.119s)
[555.868130] Starting dynamic subtest: C-eDP1
[556.990629] Dynamic subtest C-eDP1: SUCCESS (1.132s)
[557.010329] Starting dynamic subtest: D-eDP1
[558.122755] Dynamic subtest D-eDP1: SUCCESS (1.129s)
[558.127666] Subtest nonexisting-fb: SUCCESS (4.586s)
[559.313484] [095/133] (466s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[559.376445] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[559.484098] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.107s)
[559.562718] [096/133] (465s left) kms_content_protection (atomic-dpms)
[559.708756] Starting subtest: atomic-dpms
[559.713542] Subtest atomic-dpms: SKIP (0.000s)
[559.830389] [097/133] (465s left) gem_exec_capture (capture)
[559.901993] Starting subtest: capture
[559.903899] Starting dynamic subtest: rcs0-smem
[560.732786] Dynamic subtest rcs0-smem: SUCCESS (0.830s)
[560.743515] Starting dynamic subtest: bcs0-smem
[561.558990] Dynamic subtest bcs0-smem: SUCCESS (0.825s)
[561.569741] Starting dynamic subtest: vcs0-smem
[562.377251] Dynamic subtest vcs0-smem: SUCCESS (0.817s)
[562.385814] Starting dynamic subtest: vcs1-smem
[563.694745] Dynamic subtest vcs1-smem: SUCCESS (1.316s)
[563.705025] Starting dynamic subtest: vecs0-smem
[564.581374] Dynamic subtest vecs0-smem: FAIL (0.833s)
[564.592472] Starting dynamic subtest: ccs0-smem
[565.851580] Dynamic subtest ccs0-smem: SUCCESS (1.323s)
[565.854080] Subtest capture: FAIL (5.949s)
[565.973941] [098/133] (459s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[566.098843] Starting subtest: cursorB-vs-flipB-atomic
[566.103146] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[566.242026] [099/133] (459s left) gem_pxp (protected-raw-src-copy-not-readible)
[566.372784] Starting subtest: protected-raw-src-copy-not-readible
[566.431326] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.061s)
[566.562176] [100/133] (459s left) i915_pm_rc6_residency (rc6-fence)
[566.615242] Starting subtest: rc6-fence
[566.642981] Starting dynamic subtest: gt0
[578.961962] Dynamic subtest gt0: SUCCESS (12.315s)
[578.973887] Starting dynamic subtest: gt1
[592.637995] Dynamic subtest gt1: SUCCESS (13.671s)
[592.640753] Subtest rc6-fence: SUCCESS (26.021s)
[592.718245] [101/133] (433s left) kms_async_flips (crc-atomic)
[592.822569] Starting subtest: crc-atomic
[593.209325] Starting dynamic subtest: pipe-A-eDP-1
[596.123831] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.912s)
[596.503405] Starting dynamic subtest: pipe-B-eDP-1
[599.362962] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.869s)
[599.747065] Starting dynamic subtest: pipe-C-eDP-1
[602.585428] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.848s)
[602.950340] Starting dynamic subtest: pipe-D-eDP-1
[605.811475] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.868s)
[605.813604] Subtest crc-atomic: SUCCESS (12.987s)
[606.991137] [102/133] (418s left) kms_psr (fbc-pr-cursor-render)
[607.097135] Starting subtest: fbc-pr-cursor-render
[607.101585] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[607.166150] [103/133] (418s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[607.286664] Starting subtest: basic-busy-flip-before-cursor-varying-size
[607.291321] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[607.428115] [104/133] (418s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[607.523233] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[614.281945] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.759s)
[614.384845] [105/133] (411s left) gem_exec_whisper (basic-contexts-priority)
[614.451122] Starting subtest: basic-contexts-priority
[639.018056] Subtest basic-contexts-priority: SUCCESS (24.561s)
[639.204243] [106/133] (386s left) kms_color (ctm-max)
[639.292972] Starting subtest: ctm-max
[639.294866] Starting dynamic subtest: pipe-A-eDP-1
[640.001656] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.709s)
[640.012011] Starting dynamic subtest: pipe-B-eDP-1
[641.438183] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.437s)
[641.448654] Starting dynamic subtest: pipe-C-eDP-1
[642.812193] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.372s)
[642.821912] Starting dynamic subtest: pipe-D-eDP-1
[644.144756] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.331s)
[644.147115] Subtest ctm-max: SUCCESS (4.852s)
[644.938119] [107/133] (381s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[645.042170] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[651.927185] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.889s)
[652.078141] [108/133] (373s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[652.164180] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[652.166531] Starting dynamic subtest: pipe-A-eDP-1
[668.453554] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.442s)
[668.463408] Starting dynamic subtest: pipe-B-eDP-1
[685.398918] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.347s)
[685.409788] Starting dynamic subtest: pipe-C-eDP-1
[702.411411] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.372s)
[702.421807] Starting dynamic subtest: pipe-D-eDP-1
[719.400727] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.345s)
[719.402976] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (8.511s)
[720.598196] [109/133] (305s left) kms_psr (fbc-pr-sprite-plane-move)
[720.703632] Starting subtest: fbc-pr-sprite-plane-move
[720.708349] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[720.793094] [110/133] (305s left) kms_pm_rpm (basic-rte)
[720.829337] Starting subtest: basic-rte
[723.869089] Subtest basic-rte: SUCCESS (2.925s)
[725.373224] [111/133] (300s left) gem_ctx_shared (q-out-order)
[725.446926] Starting subtest: Q-out-order
[725.449351] Starting dynamic subtest: rcs0
[725.595600] Dynamic subtest rcs0: SUCCESS (0.143s)
[725.609057] Starting dynamic subtest: vcs0
[725.699672] Dynamic subtest vcs0: SUCCESS (0.102s)
[725.717499] Starting dynamic subtest: vcs1
[725.786377] Dynamic subtest vcs1: SUCCESS (0.083s)
[725.803691] Starting dynamic subtest: vecs0
[725.866636] Dynamic subtest vecs0: SUCCESS (0.078s)
[725.884434] Starting dynamic subtest: ccs0
[725.947601] Dynamic subtest ccs0: SUCCESS (0.078s)
[725.950242] Subtest Q-out-order: SUCCESS (0.489s)
[727.185557] [112/133] (298s left) kms_big_fb (linear-8bpp-rotate-0)
[727.280732] Starting subtest: linear-8bpp-rotate-0
[728.513703] Subtest linear-8bpp-rotate-0: SUCCESS (1.212s)
[728.639893] [113/133] (297s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[728.732611] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[728.736014] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[728.821245] [114/133] (297s left) gem_softpin (evict-prime-sanity-check)
[728.878300] Starting subtest: evict-prime-sanity-check
[728.880251] Starting dynamic subtest: rcs0
[730.031034] Dynamic subtest rcs0: SUCCESS (1.136s)
[730.043591] Starting dynamic subtest: bcs0
[731.159145] Dynamic subtest bcs0: SUCCESS (1.114s)
[731.170783] Starting dynamic subtest: vcs0
[733.046148] Dynamic subtest vcs0: SUCCESS (1.867s)
[733.057790] Starting dynamic subtest: vcs1
[735.029895] Dynamic subtest vcs1: SUCCESS (1.967s)
[735.041420] Starting dynamic subtest: vecs0
[737.073153] Dynamic subtest vecs0: SUCCESS (2.029s)
[737.083295] Starting dynamic subtest: ccs0
[738.194111] Dynamic subtest ccs0: SUCCESS (1.114s)
[738.204215] Starting dynamic subtest: all
[739.321428] Dynamic subtest all: SUCCESS (1.119s)
[739.324250] Subtest evict-prime-sanity-check: SUCCESS (10.358s)
[739.432018] [115/133] (286s left) dmabuf_sync_file (export-multiwait)
[739.485832] Starting subtest: export-multiwait
[739.487861] Subtest export-multiwait: SUCCESS (0.000s)
[739.546929] [116/133] (286s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[739.645422] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[746.954003] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.290s)
[747.069933] [117/133] (279s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier-source-clamping)
[747.157304] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier-source-clamping
[747.161688] Subtest pixel-format-4-tiled-bmg-ccs-modifier-source-clamping: SKIP (0.000s)
[747.232199] [118/133] (279s left) gem_create (create-ext-set-pat)
[747.388933] Starting subtest: create-ext-set-pat
[747.391520] Subtest create-ext-set-pat: SUCCESS (0.001s)
[747.506608] [119/133] (278s left) prime_vgem (busy)
[747.576917] Starting subtest: busy
[747.579427] Starting dynamic subtest: rcs0
[747.636114] Dynamic subtest rcs0: SUCCESS (0.059s)
[747.647669] Starting dynamic subtest: bcs0
[747.696215] Dynamic subtest bcs0: SUCCESS (0.059s)
[747.705694] Starting dynamic subtest: vcs0
[747.743009] Dynamic subtest vcs0: SUCCESS (0.046s)
[747.752653] Starting dynamic subtest: vcs1
[747.787486] Dynamic subtest vcs1: SUCCESS (0.044s)
[747.796945] Starting dynamic subtest: vecs0
[747.837033] Dynamic subtest vecs0: SUCCESS (0.048s)
[747.846377] Starting dynamic subtest: ccs0
[747.882473] Dynamic subtest ccs0: SUCCESS (0.044s)
[747.884705] Subtest busy: SUCCESS (0.306s)
[748.025025] [120/133] (278s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[748.121119] Starting subtest: x-tiled-64bpp-rotate-90
[748.140953] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s)
[748.256739] [121/133] (278s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[748.364703] Starting subtest: 4-tiled-32bpp-rotate-180
[749.688962] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.323s)
[749.832594] [122/133] (276s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[749.891761] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[749.944310] [123/133] (276s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[750.041252] Starting subtest: yf-tiled-32bpp-rotate-90
[750.044793] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[750.121706] [124/133] (276s left) gem_mmap_wc (write-prefaulted)
[750.179847] Subtest write-prefaulted: SKIP (0.000s)
[750.239539] [125/133] (276s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[750.350395] Starting subtest: cursorA-vs-flipA-legacy
[761.457149] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.116s)
[762.288355] [126/133] (264s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[762.413395] Starting subtest: 2x-long-flip-vs-cursor-legacy
[762.417757] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.001s)
[762.559820] [127/133] (264s left) gem_mmap_gtt (big-bo)
[762.621540] Subtest big-bo: SKIP (0.000s)
[762.678995] [128/133] (264s left) gem_exercise_blt (fast-copy-emit)
[762.741334] Starting subtest: fast-copy-emit
[762.743245] Starting dynamic subtest: linear-smem-smem-emit
[762.761305] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.022s)
[762.771432] Starting dynamic subtest: xmajor-smem-smem-emit
[762.789722] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.028s)
[762.798646] Starting dynamic subtest: tile4-smem-smem-emit
[762.806954] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.016s)
[762.815918] Starting dynamic subtest: tile64-smem-smem-emit
[762.823366] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.016s)
[762.825614] Subtest fast-copy-emit: SUCCESS (0.085s)
[762.968669] [129/133] (263s left) perf (gen8-unprivileged-single-ctx-counters)
[763.090273] Starting subtest: gen8-unprivileged-single-ctx-counters
[763.094406] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[763.133434] [130/133] (263s left) gem_exec_reloc (basic-cpu-read)
[763.185457] Subtest basic-cpu-read: SKIP (0.000s)
[763.262072] [131/133] (263s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[763.349168] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[763.352646] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[763.445653] [132/133] (263s left) i915_pm_rps (thresholds-idle-park)
[763.506289] Starting subtest: thresholds-idle-park
[763.509940] Subtest thresholds-idle-park: SKIP (0.001s)
[763.608774] [133/133] (263s left) gem_exec_params (rsvd2-dirt)
[763.668057] Starting subtest: rsvd2-dirt
[763.671941] Subtest rsvd2-dirt: SKIP (0.000s)
[763.767324] Closing watchdogs
results: parsing output: 0/ for test: gem_mmap_gtt
results: parsing output: 1/ for test: kms_plane
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: syncobj_wait
results: parsing output: 4/ for test: kms_cursor_legacy
results: parsing output: 5/ for test: kms_chamelium_frames
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_dp_linktrain_fallback
results: parsing output: 10/ for test: gem_exec_balancer
results: parsing output: 11/ for test: gem_eio
results: parsing output: 12/ for test: syncobj_timeline
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: sw_sync
results: parsing output: 17/ for test: kms_setmode
results: parsing output: 18/ for test: kms_psr
results: parsing output: 19/ for test: kms_psr
results: parsing output: 20/ for test: kms_pipe_crc_basic
results: parsing output: 21/ for test: kms_flip
results: parsing output: 22/ for test: gem_bad_reloc
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: gem_ccs
results: parsing output: 25/ for test: gen9_exec_parse
results: parsing output: 26/ for test: perf_pmu
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: gem_exec_schedule
results: parsing output: 29/ for test: kms_joiner
results: parsing output: 30/ for test: prime_vgem
results: parsing output: 31/ for test: gem_exec_create
results: parsing output: 32/ for test: gem_exec_fence
results: parsing output: 33/ for test: api_intel_bb
results: parsing output: 34/ for test: gem_exec_reloc
results: parsing output: 35/ for test: gem_workarounds
results: parsing output: 36/ for test: prime_mmap
results: parsing output: 37/ for test: kms_ccs
results: parsing output: 38/ for test: gen9_exec_parse
results: parsing output: 39/ for test: gem_exec_schedule
results: parsing output: 40/ for test: kms_dsc
results: parsing output: 41/ for test: kms_cursor_crc
results: parsing output: 42/ for test: kms_psr2_sf
results: parsing output: 43/ for test: vgem_basic
results: parsing output: 44/ for test: gem_render_copy
results: parsing output: 45/ for test: gem_eio
results: parsing output: 46/ for test: kms_flip
results: parsing output: 47/ for test: kms_ccs
results: parsing output: 48/ for test: kms_properties
results: parsing output: 49/ for test: perf_pmu
results: parsing output: 50/ for test: kms_vblank
results: parsing output: 51/ for test: syncobj_wait
results: parsing output: 52/ for test: kms_universal_plane
results: parsing output: 53/ for test: gem_exec_schedule
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: kms_atomic_transition
results: parsing output: 56/ for test: syncobj_wait
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_flip
results: parsing output: 59/ for test: gem_ctx_persistence
results: parsing output: 60/ for test: syncobj_timeline
results: parsing output: 61/ for test: gem_exec_params
results: parsing output: 62/ for test: kms_addfb_basic
results: parsing output: 63/ for test: kms_ccs
results: parsing output: 64/ for test: syncobj_timeline
results: parsing output: 65/ for test: kms_flip_scaled_crc
results: parsing output: 66/ for test: kms_cursor_crc
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: i915_hangman
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: core_auth
results: parsing output: 71/ for test: kms_properties
results: parsing output: 72/ for test: gem_ctx_param
results: parsing output: 73/ for test: kms_prop_blob
results: parsing output: 74/ for test: kms_cursor_legacy
results: parsing output: 75/ for test: kms_plane_scaling
results: parsing output: 76/ for test: kms_busy
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_plane_scaling
results: parsing output: 79/ for test: kms_ccs
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_chamelium_hpd
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_flip
results: parsing output: 84/ for test: gem_mmap_gtt
results: parsing output: 85/ for test: syncobj_timeline
results: parsing output: 86/ for test: gem_vm_create
results: parsing output: 87/ for test: gem_mmap_gtt
results: parsing output: 88/ for test: kms_lease
results: parsing output: 89/ for test: gem_mmap_gtt
results: parsing output: 90/ for test: gem_mmap_gtt
results: parsing output: 91/ for test: kms_scaling_modes
results: parsing output: 92/ for test: kms_cursor_legacy
results: parsing output: 93/ for test: kms_flip
results: parsing output: 94/ for test: syncobj_wait
results: parsing output: 95/ for test: kms_content_protection
results: parsing output: 96/ for test: gem_exec_capture
results: parsing output: 97/ for test: kms_cursor_legacy
results: parsing output: 98/ for test: gem_pxp
results: parsing output: 99/ for test: i915_pm_rc6_residency
results: parsing output: 100/ for test: kms_async_flips
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: kms_cursor_legacy
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: gem_exec_whisper
results: parsing output: 105/ for test: kms_color
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: kms_psr
results: parsing output: 109/ for test: kms_pm_rpm
results: parsing output: 110/ for test: gem_ctx_shared
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_softpin
results: parsing output: 114/ for test: dmabuf_sync_file
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_plane
results: parsing output: 117/ for test: gem_create
results: parsing output: 118/ for test: prime_vgem
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: kms_pipe_b_c_ivb
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: gem_mmap_wc
results: parsing output: 124/ for test: kms_cursor_legacy
results: parsing output: 125/ for test: kms_cursor_legacy
results: parsing output: 126/ for test: gem_mmap_gtt
results: parsing output: 127/ for test: gem_exercise_blt
results: parsing output: 128/ for test: perf
results: parsing output: 129/ for test: gem_exec_reloc
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: i915_pm_rps
results: parsing output: 132/ for test: gem_exec_params
Done.