[57.510332] Initializing watchdogs
[57.510375]   /dev/watchdog0
[57.523516] [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]
[57.527843] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.530063] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.533309] [001/134] (960s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[57.659537] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[57.669885] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.010s)
[57.750222] [002/134] (960s left) kms_addfb_basic (invalid-get-prop-any)
[57.802863] Starting subtest: invalid-get-prop-any
[57.804873] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[57.961756] [003/134] (960s left) kms_plane (plane-panning-bottom-right)
[58.051322] Starting subtest: plane-panning-bottom-right
[58.053689] Starting dynamic subtest: pipe-A
[59.803723] Dynamic subtest pipe-A: SUCCESS (1.746s)
[59.812628] Starting dynamic subtest: pipe-B
[62.159484] Dynamic subtest pipe-B: SUCCESS (2.353s)
[62.161829] Subtest plane-panning-bottom-right: SUCCESS (4.102s)
[62.991110] [004/134] (955s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[63.094343] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[63.098665] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[63.175805] [005/134] (955s left) syncobj_eventfd (invalid-bad-pad)
[63.224936] Starting subtest: invalid-bad-pad
[63.227127] Subtest invalid-bad-pad: SUCCESS (0.000s)
[63.342060] [006/134] (954s left) kms_async_flips (test-time-stamp)
[63.446290] Starting subtest: test-time-stamp
[63.821115] Starting dynamic subtest: pipe-A-eDP-1
[64.586685] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.762s)
[64.963948] Starting dynamic subtest: pipe-B-eDP-1
[65.723456] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.764s)
[66.085709] Starting dynamic subtest: pipe-C-eDP-1
[66.851848] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.771s)
[67.217253] Starting dynamic subtest: pipe-D-eDP-1
[67.984887] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.770s)
[67.987118] Subtest test-time-stamp: SUCCESS (4.531s)
[69.148811] [007/134] (949s left) gem_fence_thrash (bo-copy)
[69.190534] Starting subtest: bo-copy
[69.218976] Subtest bo-copy: SKIP (0.027s)
[69.283766] [008/134] (949s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[69.378728] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[69.405314] Starting dynamic subtest: pipe-A-plane-0
[69.838589] Dynamic subtest pipe-A-plane-0: SUCCESS (0.433s)
[69.847331] Starting dynamic subtest: pipe-A-plane-3
[70.104920] Dynamic subtest pipe-A-plane-3: SUCCESS (0.266s)
[70.112487] Starting dynamic subtest: pipe-A-plane-5
[70.118409] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[71.240298] Starting dynamic subtest: pipe-B-plane-0
[71.664713] Dynamic subtest pipe-B-plane-0: SUCCESS (0.433s)
[71.675693] Starting dynamic subtest: pipe-B-plane-3
[71.920713] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[71.929610] Starting dynamic subtest: pipe-B-plane-5
[71.933788] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[72.229886] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.849s)
[73.124039] [009/134] (945s left) kms_psr (psr2-cursor-mmap-gtt)
[73.216558] Starting subtest: psr2-cursor-mmap-gtt
[73.218722] Starting dynamic subtest: eDP-1
[74.889556] Dynamic subtest eDP-1: SUCCESS (1.671s)
[74.892121] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.672s)
[75.700545] [010/134] (942s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[75.796216] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[75.800773] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[76.938562] [011/134] (941s left) gem_eio (wait-1us)
[77.142283] Starting subtest: wait-1us
[77.433138] Subtest wait-1us: SUCCESS (0.292s)
[77.580259] [012/134] (940s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[77.684288] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[77.688289] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[77.796230] [013/134] (940s left) kms_big_fb (y-tiled-addfb-size-overflow)
[77.895783] Starting subtest: y-tiled-addfb-size-overflow
[77.899236] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s)
[77.999286] [014/134] (940s left) kms_cursor_crc (cursor-onscreen-max-size)
[78.296549] Starting subtest: cursor-onscreen-max-size
[78.301911] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[78.447071] [015/134] (940s left) gem_exec_schedule (u-semaphore-resolve)
[78.530145] Starting subtest: u-semaphore-resolve
[78.569026] Subtest u-semaphore-resolve: SUCCESS (0.039s)
[78.944989] [016/134] (939s left) kms_psr (fbc-pr-suspend)
[79.039331] Starting subtest: fbc-pr-suspend
[79.043839] Subtest fbc-pr-suspend: SKIP (0.000s)
[79.121639] [017/134] (939s left) kms_psr (psr-primary-mmap-gtt)
[79.215724] Starting subtest: psr-primary-mmap-gtt
[79.217935] Starting dynamic subtest: eDP-1
[80.629968] Dynamic subtest eDP-1: SKIP (1.410s)
[80.634793] Subtest psr-primary-mmap-gtt: SKIP (1.412s)
[80.819165] [018/134] (937s left) core_setmaster (master-drop-set-shared-fd)
[80.926532] Starting subtest: master-drop-set-shared-fd
[80.948115] Subtest master-drop-set-shared-fd: SUCCESS (0.022s)
[80.982290] [019/134] (937s left) kms_psr (fbc-psr2-sprite-render)
[81.080919] Starting subtest: fbc-psr2-sprite-render
[81.082867] Starting dynamic subtest: eDP-1
[81.087030] Dynamic subtest eDP-1: SKIP (0.000s)
[81.091183] Subtest fbc-psr2-sprite-render: SKIP (0.000s)
[81.162423] [020/134] (937s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[81.254842] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[84.979391] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.727s)
[86.181755] [021/134] (932s left) kms_flip (plain-flip-fb-recreate-interruptible)
[86.276309] Starting subtest: plain-flip-fb-recreate-interruptible
[86.278712] Starting dynamic subtest: A-eDP1
[95.136396] Dynamic subtest A-eDP1: SUCCESS (8.858s)
[95.152909] Starting dynamic subtest: B-eDP1
[103.976498] Dynamic subtest B-eDP1: SUCCESS (8.838s)
[103.996546] Starting dynamic subtest: C-eDP1
[112.890752] Dynamic subtest C-eDP1: SUCCESS (8.912s)
[112.899594] Starting dynamic subtest: D-eDP1
[121.727847] Dynamic subtest D-eDP1: SUCCESS (8.836s)
[121.732204] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.455s)
[122.913277] [022/134] (895s left) gem_render_copy_redux (interruptible)
[122.979969] Starting subtest: interruptible
[123.293126] Subtest interruptible: SUCCESS (0.313s)
[123.441617] [023/134] (895s left) syncobj_timeline (invalid-wait-illegal-handle)
[123.495975] Starting subtest: invalid-wait-illegal-handle
[123.497863] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[123.627658] [024/134] (895s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[123.720394] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[131.020947] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.304s)
[131.186800] [025/134] (887s left) gem_exec_reloc (basic-wc-read-active)
[131.259014] Subtest basic-wc-read-active: SKIP (0.000s)
[131.334822] [026/134] (887s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[131.397167] Starting subtest: multi-wait-for-submit-submitted-signaled
[131.399090] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[131.535309] [027/134] (887s left) kms_chamelium_hpd (hdmi-hpd-fast)
[131.933102] Subtest hdmi-hpd-fast: SKIP (0.000s)
[132.736182] [028/134] (886s left) kms_vblank (wait-forked-hang)
[132.835394] Starting subtest: wait-forked-hang
[132.837323] Starting dynamic subtest: pipe-A-eDP-1
[159.639566] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.800s)
[159.658071] Starting dynamic subtest: pipe-D-eDP-1
[184.654698] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.012s)
[184.657112] Subtest wait-forked-hang: SUCCESS (51.820s)
[185.536466] [029/134] (833s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[185.640063] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[185.644351] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[185.749653] [030/134] (833s left) kms_prop_blob (invalid-get-prop)
[185.808098] Starting subtest: invalid-get-prop
[185.810539] Subtest invalid-get-prop: SUCCESS (0.000s)
[185.906137] [031/134] (833s left) syncobj_timeline (etime-single-wait-all-submitted)
[185.954019] Starting subtest: etime-single-wait-all-submitted
[186.057045] Subtest etime-single-wait-all-submitted: SUCCESS (0.103s)
[186.141940] [032/134] (833s left) syncobj_timeline (single-wait-all-available-submitted)
[186.197291] Starting subtest: single-wait-all-available-submitted
[186.199609] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[186.290199] [033/134] (832s left) kms_content_protection (srm)
[186.430837] Starting subtest: srm
[186.438259] Subtest srm: SKIP (0.003s)
[186.582578] [034/134] (832s left) kms_vblank (query-forked-busy-hang)
[186.674801] Starting subtest: query-forked-busy-hang
[186.677121] Starting dynamic subtest: pipe-A-eDP-1
[213.660701] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.985s)
[213.673288] Starting dynamic subtest: pipe-D-eDP-1
[228.730395] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.066s)
[228.732742] Subtest query-forked-busy-hang: SUCCESS (42.055s)
[229.616227] [035/134] (789s left) i915_drm_fdinfo (busy-check-all)
[229.653012] Starting subtest: busy-check-all
[229.655276] Starting dynamic subtest: rcs0
[229.659809] Dynamic subtest rcs0: SKIP (0.005s)
[229.673236] Starting dynamic subtest: bcs0
[229.677135] Dynamic subtest bcs0: SKIP (0.000s)
[229.685083] Starting dynamic subtest: vcs0
[229.689328] Dynamic subtest vcs0: SKIP (0.000s)
[229.696279] Starting dynamic subtest: vcs1
[229.700162] Dynamic subtest vcs1: SKIP (0.000s)
[229.707815] Starting dynamic subtest: vecs0
[229.711783] Dynamic subtest vecs0: SKIP (0.000s)
[229.719101] Starting dynamic subtest: ccs0
[229.723366] Dynamic subtest ccs0: SKIP (0.000s)
[229.727575] Subtest busy-check-all: SKIP (0.009s)
[229.763758] [036/134] (789s left) kms_psr (fbc-pr-cursor-blt)
[229.901285] Starting subtest: fbc-pr-cursor-blt
[229.905340] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[229.984014] [037/134] (789s left) kms_psr (psr-cursor-blt)
[230.078830] Starting subtest: psr-cursor-blt
[230.081125] Starting dynamic subtest: eDP-1
[231.789628] Dynamic subtest eDP-1: SUCCESS (1.711s)
[231.792046] Subtest psr-cursor-blt: SUCCESS (1.712s)
[232.668403] [038/134] (786s left) gem_eio (hibernate)
[232.858295] Starting subtest: hibernate
[247.447084] Subtest hibernate: SUCCESS (14.587s)
[254.649454] [039/134] (771s left) api_intel_bb (purge-bb)
[254.732780] Starting subtest: purge-bb
[254.738493] Subtest purge-bb: SUCCESS (0.006s)
[254.902978] [040/134] (771s left) kms_properties (get_properties-sanity-non-atomic)
[255.029112] Starting subtest: get_properties-sanity-non-atomic
[255.031451] Subtest get_properties-sanity-non-atomic: SUCCESS (0.003s)
[255.116325] [041/134] (771s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[255.206893] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[255.579939] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[258.338886] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.757s)
[258.347616] Starting dynamic subtest: pipe-A-eDP-1-4
[260.535713] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.196s)
[260.547431] Starting dynamic subtest: pipe-A-eDP-1-4
[262.546427] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[262.557075] Starting dynamic subtest: pipe-A-eDP-1-x
[264.728932] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.178s)
[265.096498] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[267.874101] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.789s)
[267.885610] Starting dynamic subtest: pipe-B-eDP-1-4
[270.057548] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.183s)
[270.072777] Starting dynamic subtest: pipe-B-eDP-1-4
[272.068338] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[272.077708] Starting dynamic subtest: pipe-B-eDP-1-x
[274.257454] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[274.637400] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[277.402722] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.772s)
[277.413921] Starting dynamic subtest: pipe-C-eDP-1-4
[279.577294] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.173s)
[279.590196] Starting dynamic subtest: pipe-C-eDP-1-4
[281.587303] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[281.602698] Starting dynamic subtest: pipe-C-eDP-1-x
[283.765727] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.177s)
[284.127164] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[286.927068] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.806s)
[286.938735] Starting dynamic subtest: pipe-D-eDP-1-4
[289.099427] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.171s)
[289.110753] Starting dynamic subtest: pipe-D-eDP-1-4
[291.110046] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.010s)
[291.122796] Starting dynamic subtest: pipe-D-eDP-1-x
[293.288615] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s)
[293.291121] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.082s)
[294.524590] [042/134] (732s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[294.592442] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[294.599238] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[294.798269] [043/134] (731s left) gem_exec_balancer (indices)
[294.865209] Starting subtest: indices
[296.883223] Subtest indices: SUCCESS (2.016s)
[297.216376] [044/134] (729s left) gem_close_race (multigpu-basic-process)
[297.281208] Starting subtest: multigpu-basic-process
[297.285836] Subtest multigpu-basic-process: SKIP (0.000s)
[297.566730] [045/134] (729s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[297.667472] Starting subtest: fbc-1p-pri-indfb-multidraw
[310.713761] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (13.050s)
[312.070096] [046/134] (714s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[312.197944] Starting subtest: flip-vs-cursor-toggle
[320.476992] Subtest flip-vs-cursor-toggle: SUCCESS (8.280s)
[321.273541] [047/134] (705s left) gem_exec_reloc (basic-write-read-noreloc)
[321.356688] Subtest basic-write-read-noreloc: SKIP (0.000s)
[321.439049] [048/134] (705s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[321.540983] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[321.545444] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[321.687218] [049/134] (705s left) gem_exec_schedule (fifo)
[321.769594] Starting subtest: fifo
[321.771711] Starting dynamic subtest: rcs0
[321.873159] Dynamic subtest rcs0: SUCCESS (0.111s)
[321.884600] Starting dynamic subtest: vcs0
[321.950530] Dynamic subtest vcs0: SUCCESS (0.077s)
[321.961695] Starting dynamic subtest: vcs1
[322.039071] Dynamic subtest vcs1: SUCCESS (0.086s)
[322.048513] Starting dynamic subtest: vecs0
[322.116937] Dynamic subtest vecs0: SUCCESS (0.076s)
[322.129059] Starting dynamic subtest: ccs0
[322.207923] Dynamic subtest ccs0: SUCCESS (0.090s)
[322.210270] Subtest fifo: SUCCESS (0.447s)
[324.056196] [050/134] (702s left) kms_dsc (dsc-with-output-formats-with-bpc)
[324.156181] Starting subtest: dsc-with-output-formats-with-bpc
[324.215347] Subtest dsc-with-output-formats-with-bpc: SKIP (0.001s)
[324.252355] [051/134] (702s left) gem_userptr_blits (sync-unmap)
[324.323378] Starting subtest: sync-unmap
[324.337595] Subtest sync-unmap: SUCCESS (0.014s)
[324.506593] [052/134] (702s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[324.613355] Starting subtest: random-ccs-data-yf-tiled-ccs
[324.615508] Starting dynamic subtest: pipe-A-eDP-1
[324.639537] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[324.648784] Starting dynamic subtest: pipe-B-eDP-1
[324.671145] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[324.679619] Starting dynamic subtest: pipe-C-eDP-1
[324.703131] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[324.711587] Starting dynamic subtest: pipe-D-eDP-1
[324.735109] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[324.739504] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.004s)
[326.853219] [053/134] (700s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[326.963018] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[331.084302] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.124s)
[332.255943] [054/134] (694s left) gem_exec_flush (basic-uc-prw-default)
[332.332376] Starting subtest: basic-uc-prw-default
[337.785471] Subtest basic-uc-prw-default: SUCCESS (5.454s)
[337.980160] [055/134] (689s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[338.098542] Starting subtest: x-tiled-16bpp-rotate-90
[338.119109] Subtest x-tiled-16bpp-rotate-90: SKIP (0.020s)
[338.274861] [056/134] (688s left) gem_exec_schedule (preempt-engines)
[338.348984] Starting subtest: preempt-engines
[338.350935] Starting dynamic subtest: rcs0
[340.569035] Dynamic subtest rcs0: SUCCESS (2.226s)
[340.580652] Starting dynamic subtest: bcs0
[342.778579] Dynamic subtest bcs0: SUCCESS (2.208s)
[342.794376] Starting dynamic subtest: vcs0
[345.047816] Dynamic subtest vcs0: SUCCESS (2.268s)
[345.061941] Starting dynamic subtest: vcs1
[347.308498] Dynamic subtest vcs1: SUCCESS (2.259s)
[347.320053] Starting dynamic subtest: vecs0
[349.559891] Dynamic subtest vecs0: SUCCESS (2.249s)
[349.571507] Starting dynamic subtest: ccs0
[351.858670] Dynamic subtest ccs0: SUCCESS (2.298s)
[351.861234] Subtest preempt-engines: SUCCESS (13.518s)
[352.170862] [057/134] (675s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[352.273568] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[352.277739] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[352.395605] [058/134] (674s left) kms_plane_cursor (primary)
[352.499396] Starting subtest: primary
[352.504084] Starting dynamic subtest: pipe-A-eDP-1-size-64
[355.073489] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.574s)
[355.097300] Starting dynamic subtest: pipe-A-eDP-1-size-128
[357.631836] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.542s)
[357.656089] Starting dynamic subtest: pipe-A-eDP-1-size-256
[360.252969] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.604s)
[360.568818] Starting dynamic subtest: pipe-B-eDP-1-size-64
[363.800707] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.243s)
[363.834321] Starting dynamic subtest: pipe-B-eDP-1-size-128
[366.401579] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.583s)
[366.425641] Starting dynamic subtest: pipe-B-eDP-1-size-256
[368.968521] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.549s)
[369.324164] Starting dynamic subtest: pipe-C-eDP-1-size-64
[372.176345] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.876s)
[372.202813] Starting dynamic subtest: pipe-C-eDP-1-size-128
[374.376207] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.180s)
[374.403328] Starting dynamic subtest: pipe-C-eDP-1-size-256
[376.576161] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.181s)
[376.900319] Starting dynamic subtest: pipe-D-eDP-1-size-64
[379.794237] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.912s)
[379.821219] Starting dynamic subtest: pipe-D-eDP-1-size-128
[381.972110] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.158s)
[381.998971] Starting dynamic subtest: pipe-D-eDP-1-size-256
[384.161201] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.170s)
[384.469422] Subtest primary: SUCCESS (31.970s)
[385.278645] [059/134] (641s left) gem_mmap_offset (ptrace)
[385.340240] Starting subtest: ptrace
[385.342620] Starting dynamic subtest: smem0-wb
[385.357745] Dynamic subtest smem0-wb: SUCCESS (0.017s)
[385.366293] Starting dynamic subtest: smem0-wc
[385.376102] Dynamic subtest smem0-wc: SUCCESS (0.018s)
[385.384493] Starting dynamic subtest: smem0-uc
[385.396674] Dynamic subtest smem0-uc: SUCCESS (0.020s)
[385.398905] Subtest ptrace: SUCCESS (0.059s)
[385.527202] [060/134] (641s left) dumb_buffer (map-invalid-size)
[385.586660] Starting subtest: map-invalid-size
[385.588934] Subtest map-invalid-size: SUCCESS (0.000s)
[385.710697] [061/134] (641s left) kms_plane_scaling (planes-upscale-factor-0-25)
[385.810197] Starting subtest: planes-upscale-factor-0-25
[385.812459] Starting dynamic subtest: pipe-A
[385.869994] Dynamic subtest pipe-A: SUCCESS (0.062s)
[385.880725] Starting dynamic subtest: pipe-B
[386.996562] Dynamic subtest pipe-B: SUCCESS (1.126s)
[387.007220] Starting dynamic subtest: pipe-C
[388.113480] Dynamic subtest pipe-C: SUCCESS (1.116s)
[388.123179] Starting dynamic subtest: pipe-D
[389.248101] Dynamic subtest pipe-D: SUCCESS (1.134s)
[389.250468] Subtest planes-upscale-factor-0-25: SUCCESS (3.441s)
[390.421325] [062/134] (636s left) syncobj_basic (bad-destroy)
[390.482111] Starting subtest: bad-destroy
[390.484276] Subtest bad-destroy: SUCCESS (0.000s)
[390.616547] [063/134] (636s left) sysfs_preempt_timeout (invalid)
[390.684577] Starting subtest: invalid
[390.686897] Starting dynamic subtest: vecs0
[390.689143] Dynamic subtest vecs0: SUCCESS (0.000s)
[390.698646] Starting dynamic subtest: ccs0
[390.700742] Dynamic subtest ccs0: SUCCESS (0.000s)
[390.708643] Starting dynamic subtest: vcs0
[390.710691] Dynamic subtest vcs0: SUCCESS (0.000s)
[390.718495] Starting dynamic subtest: bcs0
[390.720621] Dynamic subtest bcs0: SUCCESS (0.000s)
[390.728917] Starting dynamic subtest: rcs0
[390.731032] Dynamic subtest rcs0: SUCCESS (0.000s)
[390.738814] Starting dynamic subtest: vcs1
[390.740979] Dynamic subtest vcs1: SUCCESS (0.000s)
[390.742848] Subtest invalid: SUCCESS (0.006s)
[390.807421] [064/134] (636s left) gem_eio (in-flight-internal-10ms)
[391.041802] Starting subtest: in-flight-internal-10ms
[393.000606] Subtest in-flight-internal-10ms: SUCCESS (1.957s)
[393.183252] [065/134] (634s left) kms_pm_dc (dc5-dpms)
[394.292076] Starting subtest: dc5-dpms
[396.381875] Subtest dc5-dpms: SUCCESS (2.089s)
[396.468423] [066/134] (631s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[396.569242] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[396.573152] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[396.708161] [067/134] (630s left) gem_softpin (evict-single-offset)
[396.767075] Starting subtest: evict-single-offset
[421.845070] Subtest evict-single-offset: SUCCESS (25.075s)
[421.936661] [068/134] (605s left) gem_mmap_wc (write-cpu-read-wc)
[422.042153] Subtest write-cpu-read-wc: SKIP (0.000s)
[422.097423] [069/134] (605s left) kms_cursor_edge_walk (64x64-top-edge)
[422.200043] Starting subtest: 64x64-top-edge
[422.202326] Starting dynamic subtest: pipe-A-eDP-1
[425.698557] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.495s)
[425.709480] Starting dynamic subtest: pipe-D-eDP-1
[428.822576] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.122s)
[428.824536] Subtest 64x64-top-edge: SUCCESS (6.622s)
[429.631555] [070/134] (598s left) gem_lmem_swapping (verify-random-ccs)
[429.681929] Subtest verify-random-ccs: SKIP (0.000s)
[429.729359] [071/134] (598s left) gem_exec_reloc (basic-write-gtt-active)
[429.794818] Subtest basic-write-gtt-active: SKIP (0.000s)
[429.856400] [072/134] (597s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[430.439247] Starting subtest: syncobj-stationary-timeline-chain-engines
[430.559031] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.120s)
[432.026126] [FACT gem_exec_fence (syncobj-stationary-timeline-chain-engines)] new: kernel.kmod_is_loaded.vgem: true
[432.029669] [073/134] (595s left) prime_busy (before-wait)
[432.082647] Starting subtest: before-wait
[432.088134] Starting dynamic subtest: rcs0
[432.131192] Dynamic subtest rcs0: SUCCESS (0.046s)
[432.142284] Starting dynamic subtest: bcs0
[432.209478] Dynamic subtest bcs0: SUCCESS (0.077s)
[432.220125] Starting dynamic subtest: vcs0
[432.250831] Dynamic subtest vcs0: SUCCESS (0.041s)
[432.260374] Starting dynamic subtest: vcs1
[432.292872] Dynamic subtest vcs1: SUCCESS (0.041s)
[432.302375] Starting dynamic subtest: vecs0
[432.334738] Dynamic subtest vecs0: SUCCESS (0.041s)
[432.344074] Starting dynamic subtest: ccs0
[432.376649] Dynamic subtest ccs0: SUCCESS (0.041s)
[432.485489] Subtest before-wait: SUCCESS (0.401s)
[432.571389] [074/134] (595s left) perf_pmu (semaphore-wait-idle)
[432.608662] Starting subtest: semaphore-wait-idle
[432.610616] Starting dynamic subtest: rcs0
[433.122824] Dynamic subtest rcs0: SUCCESS (0.513s)
[433.135036] Starting dynamic subtest: bcs0
[433.641056] Dynamic subtest bcs0: SUCCESS (0.513s)
[433.652566] Starting dynamic subtest: vcs0
[434.155568] Dynamic subtest vcs0: SUCCESS (0.512s)
[434.166954] Starting dynamic subtest: vcs1
[434.669976] Dynamic subtest vcs1: SUCCESS (0.512s)
[434.682776] Starting dynamic subtest: vecs0
[435.184781] Dynamic subtest vecs0: SUCCESS (0.512s)
[435.197636] Starting dynamic subtest: ccs0
[435.700628] Dynamic subtest ccs0: SUCCESS (0.513s)
[435.703553] Subtest semaphore-wait-idle: SUCCESS (3.092s)
[436.983177] [075/134] (590s left) kms_lease (lease-unleased-crtc)
[437.079104] Starting subtest: lease-unleased-crtc
[437.081455] Starting dynamic subtest: pipe-A-eDP-1
[437.367762] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.290s)
[437.378505] Starting dynamic subtest: pipe-B-eDP-1
[438.174658] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.804s)
[438.188529] Starting dynamic subtest: pipe-C-eDP-1
[438.190484] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[438.200424] Starting dynamic subtest: pipe-D-eDP-1
[438.202328] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[438.204150] Subtest lease-unleased-crtc: SUCCESS (1.108s)
[438.558495] [076/134] (589s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[438.686502] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[438.691159] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[438.858012] [077/134] (589s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[438.919371] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[438.921651] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[439.067607] [078/134] (588s left) kms_prop_blob (blob-prop-lifetime)
[439.130464] Starting subtest: blob-prop-lifetime
[439.135643] Subtest blob-prop-lifetime: SUCCESS (0.003s)
[439.255053] [079/134] (588s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[439.361067] Starting subtest: yf-tiled-8bpp-rotate-90
[439.365499] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[439.482743] [080/134] (588s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[439.722269] Starting subtest: cursor-rapid-movement-256x256
[439.726291] Starting dynamic subtest: pipe-A-eDP-1
[440.269052] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.541s)
[440.300832] Starting dynamic subtest: pipe-D-eDP-1
[441.457064] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.167s)
[441.459036] Subtest cursor-rapid-movement-256x256: SUCCESS (1.732s)
[442.317365] [081/134] (585s left) kms_vrr (negative-basic)
[442.421805] Starting subtest: negative-basic
[442.428393] Starting dynamic subtest: pipe-A-eDP-1
[447.844919] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.415s)
[448.120518] Subtest negative-basic: SUCCESS (5.700s)
[448.938469] [082/134] (579s left) i915_pm_rps (fence-order)
[449.011355] Starting subtest: fence-order
[451.876912] Subtest fence-order: SUCCESS (2.863s)
[452.028699] [083/134] (576s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite)
[452.137410] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite
[452.141375] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[452.259649] [084/134] (576s left) gem_ctx_param (invalid-param-get)
[452.314590] Starting subtest: invalid-param-get
[452.317062] Subtest invalid-param-get: SUCCESS (0.001s)
[452.428219] [085/134] (575s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[452.488853] Starting subtest: single-wait-for-submit-unsubmitted
[452.593396] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.103s)
[452.682066] [086/134] (575s left) i915_hangman (detector)
[452.749743] Starting subtest: detector
[452.752257] Starting dynamic subtest: rcs0
[463.860533] Dynamic subtest rcs0: SUCCESS (11.108s)
[463.873792] Starting dynamic subtest: bcs0
[475.891852] Dynamic subtest bcs0: SUCCESS (12.028s)
[475.906973] Starting dynamic subtest: vcs0
[487.794592] Dynamic subtest vcs0: SUCCESS (11.900s)
[487.806825] Starting dynamic subtest: vcs1
[498.803039] Dynamic subtest vcs1: SUCCESS (11.006s)
[498.815336] Starting dynamic subtest: vecs0
[508.851287] Dynamic subtest vecs0: SUCCESS (10.045s)
[508.863188] Starting dynamic subtest: ccs0
[520.884453] Dynamic subtest ccs0: SUCCESS (12.029s)
[520.887274] Subtest detector: SUCCESS (68.133s)
[520.985914] [087/134] (507s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[521.086124] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[522.175902] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.089s)
[522.319837] [088/134] (506s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[522.425690] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[522.429138] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[522.539064] [089/134] (505s left) kms_getfb (getfb-addfb-different-handles)
[522.624041] Starting subtest: getfb-addfb-different-handles
[522.625913] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[522.732901] [090/134] (505s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[522.835991] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[522.837797] Starting dynamic subtest: pipe-A-eDP-1
[522.854406] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[522.864837] Starting dynamic subtest: pipe-B-eDP-1
[522.879894] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[522.888584] Starting dynamic subtest: pipe-C-eDP-1
[522.903950] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[522.912400] Starting dynamic subtest: pipe-D-eDP-1
[522.928197] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[522.929726] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.005s)
[525.009538] [091/134] (503s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[525.120661] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[525.788736] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.670s)
[525.950632] [092/134] (502s left) perf (mi-rpc)
[526.080400] Starting subtest: mi-rpc
[526.084965] Subtest mi-rpc: SKIP (0.000s)
[526.124512] [093/134] (502s left) kms_chamelium_edid (vga-edid-read)
[526.518914] Subtest vga-edid-read: SKIP (0.000s)
[527.316386] [094/134] (501s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[527.384679] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[527.463555] [095/134] (501s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[527.584570] Starting subtest: 2x-long-cursor-vs-flip-atomic
[527.589175] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[527.744024] [096/134] (501s left) sw_sync (sync_multi_consumer_producer)
[527.778111] Starting subtest: sync_multi_consumer_producer
[528.097909] Subtest sync_multi_consumer_producer: SUCCESS (0.323s)
[528.176673] [097/134] (500s left) gem_render_copy_redux (normal)
[528.233609] Starting subtest: normal
[528.521542] Subtest normal: SUCCESS (0.291s)
[528.640127] [098/134] (500s left) kms_color (ctm-signed)
[528.738799] Starting subtest: ctm-signed
[528.741039] Starting dynamic subtest: pipe-A-eDP-1
[530.822452] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.083s)
[530.832278] Starting dynamic subtest: pipe-B-eDP-1
[533.691538] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.869s)
[533.701537] Starting dynamic subtest: pipe-C-eDP-1
[536.405172] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.713s)
[536.415956] Starting dynamic subtest: pipe-D-eDP-1
[539.089432] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.681s)
[539.091398] Subtest ctm-signed: SUCCESS (10.350s)
[539.919062] [099/134] (488s left) gem_ctx_isolation (nonpriv-switch)
[539.991849] Starting subtest: nonpriv-switch
[539.994347] Starting dynamic subtest: rcs0
[540.252052] Dynamic subtest rcs0: SUCCESS (0.260s)
[540.269704] Starting dynamic subtest: bcs0
[540.531150] Dynamic subtest bcs0: SUCCESS (0.278s)
[540.542153] Starting dynamic subtest: vcs0
[540.830499] Dynamic subtest vcs0: SUCCESS (0.298s)
[540.840069] Starting dynamic subtest: vcs1
[542.166670] Dynamic subtest vcs1: SUCCESS (1.335s)
[542.176279] Starting dynamic subtest: vecs0
[544.180451] Dynamic subtest vecs0: SUCCESS (2.013s)
[544.189945] Starting dynamic subtest: ccs0
[546.276374] Dynamic subtest ccs0: SUCCESS (2.095s)
[546.278643] Subtest nonpriv-switch: SUCCESS (6.285s)
[546.550938] [100/134] (482s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[546.664824] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[547.643101] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (0.979s)
[547.798237] [101/134] (481s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[547.917401] Starting subtest: cursorA-vs-flipA-atomic
[559.045296] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.125s)
[559.873507] [102/134] (469s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[559.987770] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[559.991797] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[560.110293] [103/134] (468s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[560.209863] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[560.212098] Starting dynamic subtest: pipe-A-eDP-1
[560.220600] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[560.231096] Starting dynamic subtest: pipe-B-eDP-1
[560.240205] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[560.252141] Starting dynamic subtest: pipe-C-eDP-1
[560.260472] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[560.269798] Starting dynamic subtest: pipe-D-eDP-1
[560.278154] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[560.282267] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.005s)
[562.530419] [104/134] (466s left) prime_vgem (fence-flip-hang)
[562.618821] Subtest fence-flip-hang: SKIP (0.000s)
[562.764267] [105/134] (466s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[562.870408] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[562.874434] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[562.994680] [106/134] (466s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[563.095224] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[563.097572] Starting dynamic subtest: pipe-A-eDP-1
[563.117753] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[563.129471] Starting dynamic subtest: pipe-B-eDP-1
[563.148373] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[563.157861] Starting dynamic subtest: pipe-C-eDP-1
[563.177643] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[563.187439] Starting dynamic subtest: pipe-D-eDP-1
[563.206745] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[563.208970] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.007s)
[565.385398] [107/134] (463s left) gem_ctx_param (invalid-ctx-set)
[565.448239] Starting subtest: invalid-ctx-set
[565.450640] Subtest invalid-ctx-set: SUCCESS (0.001s)
[565.559559] [108/134] (463s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[565.659395] Starting subtest: psr-rgb565-draw-pwrite
[572.697187] Subtest psr-rgb565-draw-pwrite: SUCCESS (7.038s)
[572.836046] [109/134] (456s left) gem_vm_create (isolation)
[572.896721] Starting subtest: isolation
[572.904307] Subtest isolation: SUCCESS (0.007s)
[573.055981] [110/134] (456s left) gem_pxp (reject-modify-context-protection-on)
[573.174179] Starting subtest: reject-modify-context-protection-on
[573.176518] Subtest reject-modify-context-protection-on: SUCCESS (0.001s)
[573.302568] [111/134] (456s left) syncobj_wait (invalid-signal-illegal-handle)
[573.357151] Starting subtest: invalid-signal-illegal-handle
[573.359485] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[573.459378] [112/134] (455s left) gem_mmap_gtt (ptrace)
[573.519395] Subtest ptrace: SKIP (0.000s)
[573.598632] [113/134] (455s left) kms_plane_multiple (tiling-none)
[573.683304] Starting subtest: tiling-none
[573.685230] Starting dynamic subtest: pipe-A-eDP-1
[577.337422] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.652s)
[577.349074] Starting dynamic subtest: pipe-B-eDP-1
[581.774331] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.436s)
[581.783965] Starting dynamic subtest: pipe-C-eDP-1
[586.112999] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.339s)
[586.125979] Starting dynamic subtest: pipe-D-eDP-1
[590.428562] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.311s)
[590.431016] Subtest tiling-none: SUCCESS (16.743s)
[591.258968] [114/134] (438s left) gem_tiled_blits (normal)
[591.316910] Subtest normal: SKIP (0.000s)
[591.392105] [115/134] (438s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[591.492194] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[591.496250] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[591.587106] [116/134] (438s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[596.602684] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[596.605104] Starting dynamic subtest: pipe-A-eDP-1
[597.410664] Dynamic subtest pipe-A-eDP-1: SKIP (0.802s)
[597.420678] Starting dynamic subtest: pipe-B-eDP-1
[598.547141] Dynamic subtest pipe-B-eDP-1: SKIP (1.135s)
[598.551204] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.942s)
[599.748911] [117/134] (429s left) gem_exec_whisper (basic-forked-all)
[599.819950] Starting subtest: basic-forked-all
[613.362047] Subtest basic-forked-all: SUCCESS (13.539s)
[613.556373] [118/134] (416s left) kms_frontbuffer_tracking (fbc-abgr161616f-draw-pwrite)
[613.657676] Starting subtest: fbc-abgr161616f-draw-pwrite
[613.662168] Subtest fbc-abgr161616f-draw-pwrite: SKIP (0.000s)
[613.788868] [119/134] (415s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[613.883428] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[621.118659] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.238s)
[621.303773] [120/134] (408s left) i915_suspend (fence-restore-untiled)
[621.378970] Starting subtest: fence-restore-untiled
[621.383089] Subtest fence-restore-untiled: SKIP (0.000s)
[621.490797] [121/134] (408s left) gem_reg_read (timestamp-monotonic)
[621.541833] Starting subtest: timestamp-monotonic
[626.326321] Subtest timestamp-monotonic: SUCCESS (4.785s)
[626.410427] [122/134] (403s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[626.513673] Starting subtest: extended-pageflip-modeset-hang-oldfb
[626.515599] Starting dynamic subtest: pipe-A
[634.412183] Dynamic subtest pipe-A: SUCCESS (7.896s)
[634.423568] Starting dynamic subtest: pipe-D
[643.076307] Dynamic subtest pipe-D: SUCCESS (8.664s)
[643.078485] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.564s)
[643.934354] [123/134] (385s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[644.042670] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[650.516459] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.484s)
[650.682700] [124/134] (379s left) gem_ctx_persistence (saturated-hostile)
[650.741962] Starting subtest: saturated-hostile
[650.744374] Starting dynamic subtest: rcs0
[651.562540] Dynamic subtest rcs0: SUCCESS (0.816s)
[651.571991] Starting dynamic subtest: bcs0
[652.361961] Dynamic subtest bcs0: SUCCESS (0.798s)
[652.374484] Starting dynamic subtest: vcs0
[653.170165] Dynamic subtest vcs0: SUCCESS (0.811s)
[653.183307] Starting dynamic subtest: vcs1
[653.988249] Dynamic subtest vcs1: SUCCESS (0.816s)
[654.000929] Starting dynamic subtest: vecs0
[654.811559] Dynamic subtest vecs0: SUCCESS (0.822s)
[654.824110] Starting dynamic subtest: ccs0
[655.670071] Dynamic subtest ccs0: SUCCESS (0.857s)
[655.672709] Subtest saturated-hostile: SUCCESS (4.930s)
[655.761725] [125/134] (374s left) gen9_exec_parse (bb-large)
[655.827750] Subtest bb-large: SKIP (0.000s)
[655.903983] [126/134] (374s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[656.158829] Starting subtest: parallel-dmabuf-import-out-fence
[657.246254] Subtest parallel-dmabuf-import-out-fence: SUCCESS (1.087s)
[657.397893] [127/134] (372s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[657.504105] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[657.508311] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[657.631586] [128/134] (372s left) kms_hdr (static-swap)
[657.726984] Starting subtest: static-swap
[657.733671] Subtest static-swap: SKIP (0.000s)
[657.865987] [129/134] (372s left) gem_ctx_shared (single-timeline)
[657.943009] Starting subtest: single-timeline
[657.971493] Subtest single-timeline: SUCCESS (0.025s)
[658.235769] [130/134] (371s left) gem_exec_whisper (basic-queues-all)
[658.300047] Starting subtest: basic-queues-all
[667.008956] Subtest basic-queues-all: SUCCESS (8.709s)
[667.206138] [131/134] (363s left) kms_flip (2x-flip-vs-panning)
[667.315406] Starting subtest: 2x-flip-vs-panning
[667.323687] Subtest 2x-flip-vs-panning: SKIP (0.010s)
[667.448552] [132/134] (362s left) kms_lease (atomic-implicit-crtc)
[667.546099] Starting subtest: atomic-implicit-crtc
[667.554972] Starting dynamic subtest: pipe-A-eDP-1
[667.574438] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[667.585194] Starting dynamic subtest: pipe-B-eDP-1
[667.595990] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[667.605430] Starting dynamic subtest: pipe-C-eDP-1
[667.616280] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[667.625816] Starting dynamic subtest: pipe-D-eDP-1
[667.637395] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[667.639338] Subtest atomic-implicit-crtc: SUCCESS (0.035s)
[667.704425] [133/134] (362s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[667.834170] Starting subtest: modeset-atomic-cursor-hotspot
[667.838713] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[667.993587] [134/134] (362s left) syncobj_wait (single-wait-signaled)
[668.058477] Starting subtest: single-wait-signaled
[668.060435] Subtest single-wait-signaled: SUCCESS (0.000s)
[668.178397] Closing watchdogs
results: parsing output: 0/ for test: kms_flip
results: parsing output: 1/ for test: kms_addfb_basic
results: parsing output: 2/ for test: kms_plane
results: parsing output: 3/ for test: kms_flip_scaled_crc
results: parsing output: 4/ for test: syncobj_eventfd
results: parsing output: 5/ for test: kms_async_flips
results: parsing output: 6/ for test: gem_fence_thrash
results: parsing output: 7/ for test: kms_plane
results: parsing output: 8/ for test: kms_psr
results: parsing output: 9/ for test: kms_ccs
results: parsing output: 10/ for test: gem_eio
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: kms_cursor_crc
results: parsing output: 14/ for test: gem_exec_schedule
results: parsing output: 15/ for test: kms_psr
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: core_setmaster
results: parsing output: 18/ for test: kms_psr
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_flip
results: parsing output: 21/ for test: gem_render_copy_redux
results: parsing output: 22/ for test: syncobj_timeline
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: gem_exec_reloc
results: parsing output: 25/ for test: syncobj_timeline
results: parsing output: 26/ for test: kms_chamelium_hpd
results: parsing output: 27/ for test: kms_vblank
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_prop_blob
results: parsing output: 30/ for test: syncobj_timeline
results: parsing output: 31/ for test: syncobj_timeline
results: parsing output: 32/ for test: kms_content_protection
results: parsing output: 33/ for test: kms_vblank
results: parsing output: 34/ for test: i915_drm_fdinfo
results: parsing output: 35/ for test: kms_psr
results: parsing output: 36/ for test: kms_psr
results: parsing output: 37/ for test: gem_eio
results: parsing output: 38/ for test: api_intel_bb
results: parsing output: 39/ for test: kms_properties
results: parsing output: 40/ for test: kms_async_flips
results: parsing output: 41/ for test: gem_render_copy
results: parsing output: 42/ for test: gem_exec_balancer
results: parsing output: 43/ for test: gem_close_race
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_cursor_legacy
results: parsing output: 46/ for test: gem_exec_reloc
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: gem_exec_schedule
results: parsing output: 49/ for test: kms_dsc
results: parsing output: 50/ for test: gem_userptr_blits
results: parsing output: 51/ for test: kms_ccs
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: gem_exec_flush
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: gem_exec_schedule
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_plane_cursor
results: parsing output: 58/ for test: gem_mmap_offset
results: parsing output: 59/ for test: dumb_buffer
results: parsing output: 60/ for test: kms_plane_scaling
results: parsing output: 61/ for test: syncobj_basic
results: parsing output: 62/ for test: sysfs_preempt_timeout
results: parsing output: 63/ for test: gem_eio
results: parsing output: 64/ for test: kms_pm_dc
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_softpin
results: parsing output: 67/ for test: gem_mmap_wc
results: parsing output: 68/ for test: kms_cursor_edge_walk
results: parsing output: 69/ for test: gem_lmem_swapping
results: parsing output: 70/ for test: gem_exec_reloc
results: parsing output: 71/ for test: gem_exec_fence
results: parsing output: 72/ for test: prime_busy
results: parsing output: 73/ for test: perf_pmu
results: parsing output: 74/ for test: kms_lease
results: parsing output: 75/ for test: kms_cursor_legacy
results: parsing output: 76/ for test: syncobj_wait
results: parsing output: 77/ for test: kms_prop_blob
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: kms_cursor_crc
results: parsing output: 80/ for test: kms_vrr
results: parsing output: 81/ for test: i915_pm_rps
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: gem_ctx_param
results: parsing output: 84/ for test: syncobj_wait
results: parsing output: 85/ for test: i915_hangman
results: parsing output: 86/ for test: kms_big_fb
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_getfb
results: parsing output: 89/ for test: kms_ccs
results: parsing output: 90/ for test: kms_big_fb
results: parsing output: 91/ for test: perf
results: parsing output: 92/ for test: kms_chamelium_edid
results: parsing output: 93/ for test: gem_fenced_exec_thrash
results: parsing output: 94/ for test: kms_cursor_legacy
results: parsing output: 95/ for test: sw_sync
results: parsing output: 96/ for test: gem_render_copy_redux
results: parsing output: 97/ for test: kms_color
results: parsing output: 98/ for test: gem_ctx_isolation
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_cursor_legacy
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_ccs
results: parsing output: 103/ for test: prime_vgem
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_ccs
results: parsing output: 106/ for test: gem_ctx_param
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: gem_vm_create
results: parsing output: 109/ for test: gem_pxp
results: parsing output: 110/ for test: syncobj_wait
results: parsing output: 111/ for test: gem_mmap_gtt
results: parsing output: 112/ for test: kms_plane_multiple
results: parsing output: 113/ for test: gem_tiled_blits
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_psr2_sf
results: parsing output: 116/ for test: gem_exec_whisper
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: i915_suspend
results: parsing output: 120/ for test: gem_reg_read
results: parsing output: 121/ for test: kms_busy
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: gem_ctx_persistence
results: parsing output: 124/ for test: gen9_exec_parse
results: parsing output: 125/ for test: gem_exec_balancer
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_hdr
results: parsing output: 128/ for test: gem_ctx_shared
results: parsing output: 129/ for test: gem_exec_whisper
results: parsing output: 130/ for test: kms_flip
results: parsing output: 131/ for test: kms_lease
results: parsing output: 132/ for test: kms_cursor_legacy
results: parsing output: 133/ for test: syncobj_wait
Done.