[60.870343] Initializing watchdogs
[60.870391]   /dev/watchdog0
[60.883917] [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]
[60.888050] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.890227] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.893445] [001/133] (960s left) syncobj_timeline (single-wait-all-available-signaled)
[60.961831] Starting subtest: single-wait-all-available-signaled
[60.964178] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[61.053883] [002/133] (960s left) kms_big_fb (4-tiled-addfb)
[61.160994] Starting subtest: 4-tiled-addfb
[61.162992] Subtest 4-tiled-addfb: SUCCESS (0.000s)
[61.255727] [003/133] (960s left) gem_exec_whisper (basic-contexts-all)
[61.315295] Starting subtest: basic-contexts-all
[72.344263] Subtest basic-contexts-all: SUCCESS (11.025s)
[72.519894] [004/133] (948s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[72.635868] Starting subtest: y-tiled-32bpp-rotate-270
[72.640380] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s)
[72.736250] [005/133] (948s left) gem_pwrite (basic-random)
[72.800274] Subtest basic-random: SKIP (0.000s)
[72.851054] [006/133] (948s left) kms_frontbuffer_tracking (fbc-tiling-y)
[72.952101] Starting subtest: fbc-tiling-y
[72.956246] Subtest fbc-tiling-y: SKIP (0.000s)
[73.057743] [007/133] (948s left) dumb_buffer (invalid-bpp)
[73.121917] Starting subtest: invalid-bpp
[73.123923] Subtest invalid-bpp: SUCCESS (0.000s)
[73.226891] [008/133] (948s left) kms_plane_lowres (tiling-none)
[73.333148] Starting subtest: tiling-none
[73.335233] Starting dynamic subtest: pipe-A-eDP-1
[73.339577] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[73.637193] Starting dynamic subtest: pipe-B-eDP-1
[73.642052] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[73.651355] Starting dynamic subtest: pipe-C-eDP-1
[73.656063] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[73.664071] Starting dynamic subtest: pipe-D-eDP-1
[73.668183] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[73.672193] Subtest tiling-none: SKIP (0.302s)
[74.503071] [009/133] (947s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[74.572729] Starting subtest: x-tiled-to-vebox-y-tiled
[74.577420] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[74.752199] [010/133] (946s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[74.810103] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[74.914217] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.103s)
[74.986718] [011/133] (946s left) kms_cursor_legacy (forked-bo)
[75.105743] Starting subtest: forked-bo
[75.108061] Starting dynamic subtest: pipe-A
[80.567472] Dynamic subtest pipe-A: SUCCESS (5.458s)
[80.582579] Starting dynamic subtest: pipe-B
[86.028276] Dynamic subtest pipe-B: SUCCESS (5.459s)
[86.037899] Starting dynamic subtest: pipe-C
[91.498863] Dynamic subtest pipe-C: SUCCESS (5.468s)
[91.508965] Starting dynamic subtest: pipe-D
[96.952804] Dynamic subtest pipe-D: SUCCESS (5.455s)
[96.963287] Starting dynamic subtest: all-pipes
[102.454183] Dynamic subtest all-pipes: SUCCESS (5.500s)
[102.456686] Subtest forked-bo: SUCCESS (27.344s)
[102.605895] [012/133] (919s left) gem_madvise (dontneed-after-mmap)
[102.658099] Starting subtest: dontneed-after-mmap
[102.677318] Subtest dontneed-after-mmap: SUCCESS (0.021s)
[102.775414] [013/133] (919s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[102.823813] Starting subtest: etime-multi-wait-all-submitted-signaled
[102.930541] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.106s)
[103.016422] [014/133] (918s left) kms_flip (wf_vblank-ts-check-interruptible)
[103.104022] Starting subtest: wf_vblank-ts-check-interruptible
[103.106308] Starting dynamic subtest: A-eDP1
[112.052606] Dynamic subtest A-eDP1: SUCCESS (8.947s)
[112.062429] Starting dynamic subtest: B-eDP1
[120.976504] Dynamic subtest B-eDP1: SUCCESS (8.923s)
[120.984635] Starting dynamic subtest: C-eDP1
[129.895833] Dynamic subtest C-eDP1: SUCCESS (8.918s)
[129.906191] Starting dynamic subtest: D-eDP1
[138.737638] Dynamic subtest D-eDP1: SUCCESS (8.842s)
[138.742821] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.639s)
[139.969932] [015/133] (881s left) gem_spin_batch (spin-each)
[140.048232] Starting subtest: spin-each
[143.315282] Subtest spin-each: SUCCESS (3.260s)
[143.972597] [016/133] (877s left) kms_psr (fbc-psr2-sprite-blt)
[144.070686] Starting subtest: fbc-psr2-sprite-blt
[144.072900] Starting dynamic subtest: eDP-1
[144.077258] Dynamic subtest eDP-1: SKIP (0.000s)
[144.081620] Subtest fbc-psr2-sprite-blt: SKIP (0.000s)
[144.148921] [017/133] (877s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[144.246672] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[144.273526] Starting dynamic subtest: pipe-A-plane-0
[144.562749] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[144.572816] Starting dynamic subtest: pipe-A-plane-3
[144.795874] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[144.805058] Starting dynamic subtest: pipe-A-plane-5
[144.809498] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[145.949543] Starting dynamic subtest: pipe-B-plane-0
[146.243016] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[146.252327] Starting dynamic subtest: pipe-B-plane-3
[146.476235] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[146.483484] Starting dynamic subtest: pipe-B-plane-5
[146.487424] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[146.797545] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.551s)
[147.632698] [018/133] (874s left) gem_workarounds (reset-context)
[147.706885] Starting subtest: reset-context
[147.862249] Subtest reset-context: SUCCESS (0.155s)
[147.985605] [019/133] (874s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[148.084232] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf
[148.088451] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[148.145710] [020/133] (873s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[148.241985] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[155.027678] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.788s)
[155.160212] [021/133] (866s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[155.258310] Starting subtest: primary-yf-tiled-reflect-x-0
[155.317427] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.059s)
[155.417152] [022/133] (866s left) kms_chamelium_color (ctm-0-75)
[155.516825] Subtest ctm-0-75: SKIP (0.000s)
[155.557394] [023/133] (866s left) kms_content_protection (atomic)
[155.692839] Starting subtest: atomic
[155.697440] Subtest atomic: SKIP (0.000s)
[155.815904] [024/133] (866s left) gem_ctx_param (invalid-param-get)
[155.865507] Starting subtest: invalid-param-get
[155.867709] Subtest invalid-param-get: SUCCESS (0.001s)
[155.978728] [025/133] (866s left) syncobj_wait (wait-for-submit-delayed-submit)
[156.028435] Starting subtest: wait-for-submit-delayed-submit
[156.132074] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[156.218491] [026/133] (866s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[156.317466] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[156.319885] Starting dynamic subtest: pipe-A-eDP-1
[156.343588] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[156.353910] Starting dynamic subtest: pipe-B-eDP-1
[156.375886] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[156.383436] Starting dynamic subtest: pipe-C-eDP-1
[156.405070] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[156.412198] Starting dynamic subtest: pipe-D-eDP-1
[156.434733] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[156.439157] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[158.617133] [027/133] (863s left) gem_exec_balancer (semaphore)
[158.679033] Starting subtest: semaphore
[159.867805] Subtest semaphore: SUCCESS (1.187s)
[160.193614] [028/133] (862s left) gem_ctx_persistence (file)
[160.255135] Starting subtest: file
[160.376696] Subtest file: SUCCESS (0.124s)
[160.500934] [029/133] (861s left) kms_async_flips (test-time-stamp-atomic)
[160.598964] Starting subtest: test-time-stamp-atomic
[160.973099] Starting dynamic subtest: pipe-A-eDP-1
[161.735197] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.759s)
[162.136107] Starting dynamic subtest: pipe-B-eDP-1
[162.866614] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.738s)
[163.246143] Starting dynamic subtest: pipe-C-eDP-1
[164.003808] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.763s)
[164.368207] Starting dynamic subtest: pipe-D-eDP-1
[165.145317] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.781s)
[165.147634] Subtest test-time-stamp-atomic: SUCCESS (4.546s)
[166.312637] [030/133] (856s left) kms_plane (planar-pixel-format-settings)
[166.405114] Starting subtest: planar-pixel-format-settings
[166.469092] Subtest planar-pixel-format-settings: SUCCESS (0.064s)
[166.608674] [031/133] (855s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[166.720950] Starting subtest: primary-4-tiled-reflect-x-0
[173.719496] Subtest primary-4-tiled-reflect-x-0: SUCCESS (7.001s)
[174.890246] [032/133] (847s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[174.986591] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[174.991026] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[175.083400] [033/133] (847s left) gem_exec_reloc (basic-cpu-gtt)
[175.149386] Subtest basic-cpu-gtt: SKIP (0.000s)
[175.221498] [034/133] (847s left) kms_universal_plane (universal-plane-sanity)
[175.312907] Starting subtest: universal-plane-sanity
[175.315222] Starting dynamic subtest: pipe-A-eDP-1
[175.906525] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.594s)
[175.915727] Starting dynamic subtest: pipe-B-eDP-1
[177.123771] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.216s)
[177.133809] Starting dynamic subtest: pipe-C-eDP-1
[178.329252] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.204s)
[178.338544] Starting dynamic subtest: pipe-D-eDP-1
[179.552484] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.223s)
[179.554868] Subtest universal-plane-sanity: SUCCESS (4.241s)
[180.420136] [035/133] (842s left) gem_mmap_offset (mmap-boundaries)
[180.484165] Starting subtest: mmap-boundaries
[180.486143] Starting dynamic subtest: smem0
[180.761855] Dynamic subtest smem0: SUCCESS (0.280s)
[180.764107] Subtest mmap-boundaries: SUCCESS (0.280s)
[180.883188] [036/133] (841s left) gem_wait (busy)
[180.950067] Starting subtest: busy
[180.952072] Starting dynamic subtest: all-engines
[182.933999] Dynamic subtest all-engines: SUCCESS (1.985s)
[182.945701] Starting dynamic subtest: rcs0
[183.478032] Dynamic subtest rcs0: SUCCESS (0.543s)
[183.488060] Starting dynamic subtest: bcs0
[184.019149] Dynamic subtest bcs0: SUCCESS (0.540s)
[184.029191] Starting dynamic subtest: vcs0
[185.877216] Dynamic subtest vcs0: SUCCESS (1.856s)
[185.888240] Starting dynamic subtest: vcs1
[187.925194] Dynamic subtest vcs1: SUCCESS (2.047s)
[187.936090] Starting dynamic subtest: vecs0
[189.909630] Dynamic subtest vecs0: SUCCESS (1.983s)
[189.920527] Starting dynamic subtest: ccs0
[190.451781] Dynamic subtest ccs0: SUCCESS (0.542s)
[190.454245] Subtest busy: SUCCESS (9.503s)
[190.644876] [037/133] (832s left) gem_create (create-valid-nonaligned)
[190.703353] Starting subtest: create-valid-nonaligned
[190.705298] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[190.890144] [038/133] (831s left) gem_media_fill (media-fill)
[190.951434] Subtest media-fill: SKIP (0.000s)
[191.081357] [039/133] (831s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[191.139958] Starting subtest: invalid-multi-wait-all-unsubmitted
[191.142330] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[191.240389] [040/133] (831s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[191.340373] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[191.342772] Starting dynamic subtest: pipe-A-eDP-1
[191.455911] Dynamic subtest pipe-A-eDP-1: SKIP (0.121s)
[191.466882] Starting dynamic subtest: pipe-B-eDP-1
[192.589124] Dynamic subtest pipe-B-eDP-1: SKIP (1.132s)
[192.593565] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.256s)
[193.779091] [041/133] (829s left) gem_create (create-ext-placement-all)
[193.953708] Starting subtest: create-ext-placement-all
[193.956238] Subtest create-ext-placement-all: SUCCESS (0.000s)
[194.049467] [042/133] (828s left) i915_pm_freq_api (freq-reset)
[194.107740] Starting subtest: freq-reset
[194.110252] Starting dynamic subtest: gt0
[194.280141] Dynamic subtest gt0: SUCCESS (0.170s)
[194.289224] Starting dynamic subtest: gt1
[194.431185] Dynamic subtest gt1: SUCCESS (0.151s)
[194.433607] Subtest freq-reset: SUCCESS (0.323s)
[194.502133] [043/133] (828s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[194.595385] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[194.598771] Starting dynamic subtest: pipe-A-eDP-1
[195.446674] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.839s)
[195.456143] Starting dynamic subtest: pipe-B-eDP-1
[196.985473] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.538s)
[196.995587] Starting dynamic subtest: pipe-C-eDP-1
[198.496614] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.510s)
[198.505638] Starting dynamic subtest: pipe-D-eDP-1
[200.029861] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.534s)
[200.032079] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.426s)
[201.210046] [044/133] (821s left) kms_flip (dpms-off-confusion-interruptible)
[201.308191] Starting subtest: dpms-off-confusion-interruptible
[201.310602] Starting dynamic subtest: A-eDP1
[209.920542] Dynamic subtest A-eDP1: SUCCESS (8.611s)
[209.929867] Starting dynamic subtest: B-eDP1
[218.540708] Dynamic subtest B-eDP1: SUCCESS (8.619s)
[218.551811] Starting dynamic subtest: C-eDP1
[227.154457] Dynamic subtest C-eDP1: SUCCESS (8.611s)
[227.163113] Starting dynamic subtest: D-eDP1
[235.784302] Dynamic subtest D-eDP1: SUCCESS (8.629s)
[235.789516] Subtest dpms-off-confusion-interruptible: SUCCESS (34.481s)
[236.954982] [045/133] (786s left) kms_chamelium_edid (hdmi-mode-timings)
[237.345614] Subtest hdmi-mode-timings: SKIP (0.000s)
[238.168354] [046/133] (784s left) gem_exec_reloc (basic-scanout)
[238.231925] Subtest basic-scanout: SKIP (0.000s)
[238.310060] [047/133] (784s left) api_intel_allocator (default-alignment)
[238.350814] Starting subtest: default-alignment
[238.352817] Subtest default-alignment: SUCCESS (0.003s)
[238.488697] [048/133] (784s left) gem_exec_schedule (u-independent)
[238.564341] Starting subtest: u-independent
[238.566182] Starting dynamic subtest: rcs0
[239.894510] Dynamic subtest rcs0: SUCCESS (1.339s)
[239.905770] Starting dynamic subtest: vcs0
[241.951066] Dynamic subtest vcs0: SUCCESS (2.055s)
[241.962663] Starting dynamic subtest: vcs1
[243.875422] Dynamic subtest vcs1: SUCCESS (1.922s)
[243.886734] Starting dynamic subtest: vecs0
[245.920370] Dynamic subtest vecs0: SUCCESS (2.043s)
[245.931130] Starting dynamic subtest: ccs0
[247.893627] Dynamic subtest ccs0: SUCCESS (1.970s)
[247.896542] Subtest u-independent: SUCCESS (9.339s)
[248.243076] [049/133] (775s left) gen7_exec_parse (cmd-crossing-page)
[248.307385] Subtest cmd-crossing-page: SKIP (0.000s)
[248.372872] [050/133] (774s left) kms_vblank (query-idle)
[248.472409] Starting subtest: query-idle
[248.474350] Starting dynamic subtest: pipe-A-eDP-1
[250.213487] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.742s)
[250.227621] Starting dynamic subtest: pipe-D-eDP-1
[252.625649] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.409s)
[252.628071] Subtest query-idle: SUCCESS (4.155s)
[253.453760] [051/133] (769s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[253.524751] Starting subtest: y-tiled-to-vebox-x-tiled
[253.529227] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[253.704588] [052/133] (769s left) gem_exec_balancer (hog)
[253.771852] Starting subtest: hog
[253.776586] Subtest hog: SKIP (0.000s)
[254.065634] [053/133] (769s left) kms_atomic_interruptible (legacy-pageflip)
[254.166530] Starting subtest: legacy-pageflip
[254.168829] Starting dynamic subtest: pipe-A-eDP-1
[261.590032] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.423s)
[261.592346] Subtest legacy-pageflip: SUCCESS (7.425s)
[262.415173] [054/133] (761s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[262.540703] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[262.545349] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[262.645078] [055/133] (760s left) gem_exec_params (invalid-flag)
[262.707284] Starting subtest: invalid-flag
[262.709488] Subtest invalid-flag: SUCCESS (0.000s)
[262.797036] [056/133] (760s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[262.885814] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[262.887968] Starting dynamic subtest: A-eDP1
[266.565376] Dynamic subtest A-eDP1: SUCCESS (3.678s)
[266.582561] Starting dynamic subtest: B-eDP1
[269.764430] Dynamic subtest B-eDP1: SUCCESS (3.200s)
[269.773098] Starting dynamic subtest: C-eDP1
[272.892041] Dynamic subtest C-eDP1: SUCCESS (3.125s)
[272.901410] Starting dynamic subtest: D-eDP1
[275.997401] Dynamic subtest D-eDP1: SUCCESS (3.107s)
[275.999722] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.116s)
[276.813351] [057/133] (746s left) gen3_render_mixed_blits
[276.934514] [058/133] (746s left) kms_addfb_basic (invalid-smem-bo-on-discrete)
[276.987068] Starting subtest: invalid-smem-bo-on-discrete
[276.991660] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s)
[277.117061] [059/133] (746s left) kms_flip (2x-flip-vs-rmfb)
[277.207876] Starting subtest: 2x-flip-vs-rmfb
[277.218950] Subtest 2x-flip-vs-rmfb: SKIP (0.010s)
[277.295448] [060/133] (746s left) kms_dsc (dsc-fractional-bpp)
[277.377268] Starting subtest: dsc-fractional-bpp
[277.390114] Subtest dsc-fractional-bpp: SKIP (0.000s)
[277.458098] [061/133] (746s left) i915_drm_fdinfo (memory-info-idle)
[277.493024] Starting subtest: memory-info-idle
[277.495327] Starting dynamic subtest: smem0
[277.551611] Dynamic subtest smem0: SUCCESS (0.058s)
[277.554107] Subtest memory-info-idle: SUCCESS (0.059s)
[277.622146] [062/133] (746s left) perf_pmu (semaphore-wait-idle)
[277.657983] Starting subtest: semaphore-wait-idle
[277.659966] Starting dynamic subtest: rcs0
[278.171345] Dynamic subtest rcs0: SUCCESS (0.513s)
[278.182286] Starting dynamic subtest: bcs0
[278.689284] Dynamic subtest bcs0: SUCCESS (0.515s)
[278.698857] Starting dynamic subtest: vcs0
[279.203612] Dynamic subtest vcs0: SUCCESS (0.511s)
[279.221878] Starting dynamic subtest: vcs1
[279.717677] Dynamic subtest vcs1: SUCCESS (0.511s)
[279.732879] Starting dynamic subtest: vecs0
[280.231870] Dynamic subtest vecs0: SUCCESS (0.511s)
[280.243498] Starting dynamic subtest: ccs0
[280.747693] Dynamic subtest ccs0: SUCCESS (0.512s)
[280.750602] Subtest semaphore-wait-idle: SUCCESS (3.092s)
[282.027638] [063/133] (741s left) kms_psr (psr2-cursor-plane-onoff)
[282.130984] Starting subtest: psr2-cursor-plane-onoff
[282.133323] Starting dynamic subtest: eDP-1
[283.791053] Dynamic subtest eDP-1: SUCCESS (1.659s)
[283.793474] Subtest psr2-cursor-plane-onoff: SUCCESS (1.660s)
[284.586958] [064/133] (739s left) perf (blocking)
[284.708385] Starting subtest: blocking
[284.710285] Starting dynamic subtest: 0-rcs0
[294.738688] Dynamic subtest 0-rcs0: SUCCESS (10.030s)
[294.746981] Starting dynamic subtest: 1-vcs0
[304.760112] Dynamic subtest 1-vcs0: SUCCESS (10.020s)
[304.763047] Subtest blocking: SUCCESS (20.053s)
[304.808805] [065/133] (719s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[304.902636] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[304.906829] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[304.996130] [066/133] (718s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[305.042321] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[305.044211] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[305.122333] [067/133] (718s left) kms_properties (connector-properties-atomic)
[305.207205] Starting subtest: connector-properties-atomic
[305.209454] Starting dynamic subtest: pipe-A-eDP-1
[313.011891] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.805s)
[313.021466] Starting dynamic subtest: pipe-None-DP-1
[313.025967] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[313.033677] Starting dynamic subtest: pipe-None-HDMI-A-1
[313.037726] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[313.045810] Starting dynamic subtest: pipe-None-DP-2
[313.050172] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[313.057741] Starting dynamic subtest: pipe-None-HDMI-A-2
[313.062280] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[313.070322] Starting dynamic subtest: pipe-None-DP-3
[313.074801] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[313.082933] Starting dynamic subtest: pipe-None-DP-4
[313.087025] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[313.088935] Subtest connector-properties-atomic: SUCCESS (7.816s)
[313.871402] [068/133] (710s left) perf (invalid-create-userspace-config)
[313.977856] Starting subtest: invalid-create-userspace-config
[313.980222] Subtest invalid-create-userspace-config: SUCCESS (0.001s)
[314.023140] [069/133] (710s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[314.128336] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[314.132401] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[314.221549] [070/133] (709s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[314.321120] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[314.325304] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[314.401989] [071/133] (709s left) kms_invalid_mode (bad-htotal)
[314.500287] Starting subtest: bad-htotal
[314.502395] Starting dynamic subtest: pipe-A-eDP-1
[314.783541] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[314.792575] Starting dynamic subtest: pipe-B-eDP-1
[314.794451] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[314.802369] Starting dynamic subtest: pipe-C-eDP-1
[314.804698] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[314.812772] Starting dynamic subtest: pipe-D-eDP-1
[314.815034] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[314.817226] Subtest bad-htotal: SUCCESS (0.289s)
[315.609307] [072/133] (708s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[315.665578] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[315.667846] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[315.767297] [073/133] (708s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[315.861181] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[322.560976] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.704s)
[322.673842] [074/133] (701s left) kms_force_connector_basic (force-connector-state)
[322.749149] Starting subtest: force-connector-state
[323.375393] Subtest force-connector-state: SUCCESS (0.626s)
[324.280671] [075/133] (699s left) kms_plane_alpha_blend (alpha-transparent-fb)
[324.378233] Starting subtest: alpha-transparent-fb
[324.653765] Starting dynamic subtest: pipe-A-eDP-1
[325.244999] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.587s)
[325.254131] Starting dynamic subtest: pipe-D-eDP-1
[326.572726] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.329s)
[326.575209] Subtest alpha-transparent-fb: SUCCESS (2.197s)
[327.453711] [076/133] (696s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[327.553238] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[327.557291] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[327.622799] [077/133] (696s left) gem_exec_schedule (preempt-contexts)
[327.691442] Starting subtest: preempt-contexts
[327.693407] Starting dynamic subtest: rcs0
[327.734853] Dynamic subtest rcs0: SUCCESS (0.051s)
[327.743349] Starting dynamic subtest: bcs0
[327.794207] Dynamic subtest bcs0: SUCCESS (0.057s)
[327.802521] Starting dynamic subtest: vcs0
[327.844432] Dynamic subtest vcs0: SUCCESS (0.048s)
[327.852569] Starting dynamic subtest: vcs1
[327.893493] Dynamic subtest vcs1: SUCCESS (0.050s)
[327.901636] Starting dynamic subtest: vecs0
[327.951830] Dynamic subtest vecs0: SUCCESS (0.056s)
[327.959631] Starting dynamic subtest: ccs0
[328.012752] Dynamic subtest ccs0: SUCCESS (0.061s)
[328.015558] Subtest preempt-contexts: SUCCESS (0.329s)
[328.998596] [078/133] (695s left) gem_busy (parallel)
[329.181508] Starting subtest: parallel
[329.183417] Starting dynamic subtest: rcs0
[330.900839] Dynamic subtest rcs0: SUCCESS (1.721s)
[330.912375] Starting dynamic subtest: bcs0
[332.886900] Dynamic subtest bcs0: SUCCESS (1.982s)
[332.898495] Starting dynamic subtest: vcs0
[334.934387] Dynamic subtest vcs0: SUCCESS (2.045s)
[334.945900] Starting dynamic subtest: vcs1
[336.917975] Dynamic subtest vcs1: SUCCESS (1.982s)
[336.929168] Starting dynamic subtest: vecs0
[338.902686] Dynamic subtest vecs0: SUCCESS (1.981s)
[338.913940] Starting dynamic subtest: ccs0
[340.909219] Dynamic subtest ccs0: SUCCESS (1.980s)
[340.913387] Subtest parallel: SUCCESS (11.705s)
[341.091559] [079/133] (683s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[341.182126] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[341.184444] Starting dynamic subtest: pipe-A
[341.205513] Dynamic subtest pipe-A: SKIP (0.018s)
[341.215236] Starting dynamic subtest: pipe-B
[341.235844] Dynamic subtest pipe-B: SKIP (0.030s)
[341.244560] Starting dynamic subtest: pipe-C
[341.265659] Dynamic subtest pipe-C: SKIP (0.030s)
[341.273979] Starting dynamic subtest: pipe-D
[341.294946] Dynamic subtest pipe-D: SKIP (0.030s)
[341.299259] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.110s)
[341.389114] [080/133] (683s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[341.478142] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[363.984917] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (22.509s)
[364.083809] [081/133] (660s left) gem_render_copy_redux (normal)
[364.152874] Starting subtest: normal
[364.493904] Subtest normal: SUCCESS (0.341s)
[364.597644] [082/133] (659s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[364.672176] Starting subtest: map-fixed-invalidate-overlap
[364.676034] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[364.793488] [083/133] (659s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted)
[364.855475] Starting subtest: multi-wait-all-for-submit-unsubmitted
[364.961858] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.106s)
[365.040343] [084/133] (659s left) kms_psr (fbc-psr-suspend)
[365.153164] Starting subtest: fbc-psr-suspend
[365.155420] Starting dynamic subtest: eDP-1
[365.159495] Dynamic subtest eDP-1: SKIP (0.000s)
[365.163642] Subtest fbc-psr-suspend: SKIP (0.001s)
[365.224290] [085/133] (659s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[365.333325] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[366.135624] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.803s)
[366.295932] [086/133] (658s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[366.389622] Starting subtest: psr-2p-primscrn-spr-indfb-move
[366.394590] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[366.488134] [087/133] (658s left) tools_test (tools_test)
[366.548912] Starting subtest: tools_test
[366.592305] Subtest tools_test: SUCCESS (0.063s)
[366.668187] [088/133] (658s left) kms_pm_rpm (basic-pci-d3-state)
[368.186375] Starting subtest: basic-pci-d3-state
[369.648147] Subtest basic-pci-d3-state: SUCCESS (1.465s)
[369.734786] [089/133] (655s left) kms_hdr (brightness-with-hdr)
[369.839280] Starting subtest: brightness-with-hdr
[369.845775] Subtest brightness-with-hdr: SKIP (0.000s)
[369.909492] [090/133] (654s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[369.978044] Subtest writes-after-reads: SKIP (0.000s)
[370.053492] [091/133] (654s left) gem_userptr_blits (stress-mm-invalidate-close)
[370.114880] Starting subtest: stress-mm-invalidate-close
[372.261903] Subtest stress-mm-invalidate-close: SUCCESS (2.148s)
[372.373192] [092/133] (652s left) gem_exec_reloc (basic-write-read-active)
[372.435516] Subtest basic-write-read-active: SKIP (0.000s)
[372.517460] [093/133] (652s left) kms_color (ctm-signed)
[372.612992] Starting subtest: ctm-signed
[372.615235] Starting dynamic subtest: pipe-A-eDP-1
[374.735062] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.122s)
[374.745022] Starting dynamic subtest: pipe-B-eDP-1
[377.499520] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.765s)
[377.508839] Starting dynamic subtest: pipe-C-eDP-1
[380.263080] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.761s)
[380.274013] Starting dynamic subtest: pipe-D-eDP-1
[382.961610] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.697s)
[382.963767] Subtest ctm-signed: SUCCESS (10.349s)
[383.754214] [094/133] (641s left) gem_exec_create (forked)
[383.815110] Starting subtest: forked
[383.817499] Starting dynamic subtest: smem
[403.999276] Dynamic subtest smem: SUCCESS (20.186s)
[404.001705] Subtest forked: SUCCESS (20.188s)
[404.201823] [095/133] (620s left) i915_pm_rc6_residency (rc6-accuracy)
[404.259663] Starting subtest: rc6-accuracy
[404.262041] Starting dynamic subtest: gt0
[407.432944] Dynamic subtest gt0: SUCCESS (3.169s)
[407.452159] Starting dynamic subtest: gt1
[410.603593] Dynamic subtest gt1: SUCCESS (3.168s)
[410.606239] Subtest rc6-accuracy: SUCCESS (6.343s)
[410.694429] [096/133] (614s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[410.798372] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[410.802312] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[410.879578] [097/133] (614s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[410.971291] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[410.973536] Starting dynamic subtest: pipe-A-eDP-1
[411.030494] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.061s)
[411.349029] Starting dynamic subtest: pipe-B-eDP-1
[412.111217] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.773s)
[412.401028] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.430s)
[413.265437] [098/133] (611s left) perf (non-zero-reason)
[413.375755] Starting subtest: non-zero-reason
[413.378489] Starting dynamic subtest: 0-rcs0
[418.674938] Dynamic subtest 0-rcs0: SUCCESS (5.301s)
[418.684895] Starting dynamic subtest: 1-vcs1
[422.543445] Dynamic subtest 1-vcs1: SUCCESS (3.868s)
[422.546440] Subtest non-zero-reason: SUCCESS (9.171s)
[422.584213] [099/133] (602s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[422.684779] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[422.688972] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[422.769806] [100/133] (602s left) i915_pm_rps (thresholds)
[422.822672] Starting subtest: thresholds
[422.827358] Subtest thresholds: SKIP (0.000s)
[422.922979] [101/133] (602s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[423.038249] Starting subtest: cursorA-vs-flipA-legacy
[434.150933] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.112s)
[434.945657] [102/133] (590s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[435.046604] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[435.050922] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[435.141644] [103/133] (590s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[435.184804] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[435.223209] [104/133] (590s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[435.316831] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[435.321246] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[435.435191] [105/133] (590s left) sysfs_heartbeat_interval (mixed)
[435.485760] Starting subtest: mixed
[435.488192] Starting dynamic subtest: vecs0
[440.680103] Dynamic subtest vecs0: SUCCESS (5.194s)
[440.691553] Starting dynamic subtest: ccs0
[445.933519] Dynamic subtest ccs0: SUCCESS (5.251s)
[445.944138] Starting dynamic subtest: vcs0
[451.129241] Dynamic subtest vcs0: SUCCESS (5.194s)
[451.144955] Starting dynamic subtest: bcs0
[456.370351] Dynamic subtest bcs0: SUCCESS (5.239s)
[456.382344] Starting dynamic subtest: rcs0
[461.564927] Dynamic subtest rcs0: SUCCESS (5.193s)
[461.576286] Starting dynamic subtest: vcs1
[466.774672] Dynamic subtest vcs1: SUCCESS (5.208s)
[466.777102] Subtest mixed: SUCCESS (31.290s)
[466.851302] [106/133] (558s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[467.143737] Starting subtest: cursor-rapid-movement-512x170
[467.147426] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[467.272408] [107/133] (558s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[467.356151] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[467.358308] Starting dynamic subtest: pipe-A-eDP-1
[467.380591] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[467.391335] Starting dynamic subtest: pipe-B-eDP-1
[467.412398] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[467.420505] Starting dynamic subtest: pipe-C-eDP-1
[467.442312] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[467.450683] Starting dynamic subtest: pipe-D-eDP-1
[467.472473] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[467.476560] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.007s)
[469.644756] [108/133] (555s left) drm_read (empty-nonblock)
[469.803066] Starting subtest: empty-nonblock
[469.805436] Subtest empty-nonblock: SUCCESS (0.000s)
[469.917919] [109/133] (555s left) kms_prime (basic-crc-hybrid)
[470.000186] Subtest basic-crc-hybrid: SKIP (0.000s)
[470.163708] [FACT kms_prime (basic-crc-hybrid)] new: kernel.kmod_is_loaded.vgem: true
[470.167368] [110/133] (555s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[470.288123] Starting subtest: basic-busy-flip-before-cursor-atomic
[470.292370] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[470.432759] [111/133] (555s left) kms_psr (fbc-psr-primary-mmap-gtt)
[470.521093] Starting subtest: fbc-psr-primary-mmap-gtt
[470.523341] Starting dynamic subtest: eDP-1
[470.527613] Dynamic subtest eDP-1: SKIP (0.000s)
[470.531820] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s)
[470.604426] [112/133] (555s left) gem_ctx_persistence (engines-mixed)
[470.657060] Starting subtest: engines-mixed
[470.658962] Starting dynamic subtest: rcs0
[470.727958] Dynamic subtest rcs0: SUCCESS (0.071s)
[470.741515] Starting dynamic subtest: bcs0
[470.771996] Dynamic subtest bcs0: SUCCESS (0.042s)
[470.781357] Starting dynamic subtest: vcs0
[470.820205] Dynamic subtest vcs0: SUCCESS (0.047s)
[470.830394] Starting dynamic subtest: vcs1
[470.866864] Dynamic subtest vcs1: SUCCESS (0.045s)
[470.878281] Starting dynamic subtest: vecs0
[470.913231] Dynamic subtest vecs0: SUCCESS (0.044s)
[470.921456] Starting dynamic subtest: ccs0
[470.958249] Dynamic subtest ccs0: SUCCESS (0.043s)
[470.960454] Subtest engines-mixed: SUCCESS (0.302s)
[471.037077] [113/133] (554s left) kms_cursor_edge_walk (256x256-left-edge)
[471.130679] Starting subtest: 256x256-left-edge
[471.132512] Starting dynamic subtest: pipe-A-eDP-1
[474.590179] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.459s)
[474.601856] Starting dynamic subtest: pipe-D-eDP-1
[477.773143] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.182s)
[477.775477] Subtest 256x256-left-edge: SUCCESS (6.644s)
[478.637525] [114/133] (547s left) gem_exec_fence (submit3)
[478.827733] Starting subtest: submit3
[478.832265] Subtest submit3: SKIP (0.000s)
[481.008411] [115/133] (544s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[481.108070] Starting subtest: yf-tiled-32bpp-rotate-0
[481.112618] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s)
[481.208276] [116/133] (544s left) kms_cursor_crc (cursor-offscreen-512x170)
[481.538448] Starting subtest: cursor-offscreen-512x170
[481.543036] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[481.695463] [117/133] (544s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[481.783531] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[488.457922] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (6.678s)
[488.569424] [118/133] (537s left) api_intel_bb (intel-bb-blit-x)
[488.632480] Starting subtest: intel-bb-blit-x
[492.313978] Subtest intel-bb-blit-x: SUCCESS (3.682s)
[492.441833] [119/133] (533s left) gem_exec_reloc (basic-gtt-read-active)
[492.508555] Subtest basic-gtt-read-active: SKIP (0.000s)
[492.586671] [120/133] (533s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[492.689485] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[492.693835] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[492.795921] [121/133] (533s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[492.911675] Starting subtest: yf-tiled-64bpp-rotate-180
[492.916460] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[492.997941] [122/133] (533s left) kms_chamelium_hpd (dp-hpd-fast)
[493.374681] Subtest dp-hpd-fast: SKIP (0.000s)
[494.222227] [123/133] (531s left) gem_exec_async (concurrent-writes)
[494.281115] Starting subtest: concurrent-writes
[494.283540] Starting dynamic subtest: rcs0
[494.297413] Dynamic subtest rcs0: SUCCESS (0.016s)
[494.308185] Starting dynamic subtest: bcs0
[494.309993] Dynamic subtest bcs0: SUCCESS (0.006s)
[494.318888] Starting dynamic subtest: vcs0
[494.321336] Dynamic subtest vcs0: SUCCESS (0.005s)
[494.330331] Starting dynamic subtest: vcs1
[494.332556] Dynamic subtest vcs1: SUCCESS (0.007s)
[494.340544] Starting dynamic subtest: vecs0
[494.342433] Dynamic subtest vecs0: SUCCESS (0.005s)
[494.350346] Starting dynamic subtest: ccs0
[494.352237] Dynamic subtest ccs0: SUCCESS (0.005s)
[494.354124] Subtest concurrent-writes: SUCCESS (0.049s)
[494.564120] [124/133] (531s left) prime_self_import (basic-with_two_bos)
[494.595333] Starting subtest: basic-with_two_bos
[494.609987] Subtest basic-with_two_bos: SUCCESS (0.016s)
[494.703951] [125/133] (531s left) perf_pmu (multi-client)
[494.742559] Starting subtest: multi-client
[494.745085] Starting dynamic subtest: rcs0
[495.781839] Dynamic subtest rcs0: SUCCESS (1.040s)
[495.791641] Starting dynamic subtest: bcs0
[496.832376] Dynamic subtest bcs0: SUCCESS (1.047s)
[496.844205] Starting dynamic subtest: vcs0
[497.887342] Dynamic subtest vcs0: SUCCESS (1.052s)
[497.898763] Starting dynamic subtest: vcs1
[499.916264] Dynamic subtest vcs1: SUCCESS (2.027s)
[499.927022] Starting dynamic subtest: vecs0
[501.900381] Dynamic subtest vecs0: SUCCESS (1.981s)
[501.911527] Starting dynamic subtest: ccs0
[503.947938] Dynamic subtest ccs0: SUCCESS (2.045s)
[503.950871] Subtest multi-client: SUCCESS (9.207s)
[504.062480] [126/133] (522s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[504.157154] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[504.159444] Starting dynamic subtest: pipe-A-default-mode
[506.906714] Dynamic subtest pipe-A-default-mode: SUCCESS (2.748s)
[506.909186] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.751s)
[507.743576] [127/133] (518s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[507.848501] Starting subtest: fbc-pr-cursor-mmap-cpu
[507.852773] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[507.926441] [128/133] (518s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[508.026930] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[508.029147] Starting dynamic subtest: pipe-A-eDP-1
[508.084684] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[508.094298] Starting dynamic subtest: pipe-B-eDP-1
[508.150277] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[508.159628] Starting dynamic subtest: pipe-C-eDP-1
[508.217445] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[508.226682] Starting dynamic subtest: pipe-D-eDP-1
[508.282326] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[508.286302] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.009s)
[510.241782] [129/133] (516s left) kms_lease (lease-invalid-crtc)
[510.333210] Starting subtest: lease-invalid-crtc
[510.335494] Starting dynamic subtest: pipe-A-eDP-1
[510.337647] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[510.345722] Starting dynamic subtest: pipe-B-eDP-1
[510.347670] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[510.356076] Starting dynamic subtest: pipe-C-eDP-1
[510.358200] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[510.366355] Starting dynamic subtest: pipe-D-eDP-1
[510.368256] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[510.370059] Subtest lease-invalid-crtc: SUCCESS (0.004s)
[510.410529] [130/133] (516s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[510.509513] Starting subtest: x-tiled-8bpp-rotate-90
[510.531113] Subtest x-tiled-8bpp-rotate-90: SKIP (0.021s)
[510.667118] [131/133] (515s left) gem_sync (basic-each)
[510.744052] Starting subtest: basic-each
[513.194423] Subtest basic-each: SUCCESS (2.462s)
[513.390707] [132/133] (513s left) syncobj_wait (multi-wait-submitted)
[513.457486] Starting subtest: multi-wait-submitted
[513.562782] Subtest multi-wait-submitted: SUCCESS (0.104s)
[513.656273] [133/133] (512s left) gem_exec_create (madvise)
[513.713706] Starting subtest: madvise
[513.716155] Starting dynamic subtest: smem
[533.865403] Dynamic subtest smem: SUCCESS (20.151s)
[533.867878] Subtest madvise: SUCCESS (20.152s)
[534.671397] Closing watchdogs
results: parsing output: 0/ for test: syncobj_timeline
results: parsing output: 1/ for test: kms_big_fb
results: parsing output: 2/ for test: gem_exec_whisper
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: gem_pwrite
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: dumb_buffer
results: parsing output: 7/ for test: kms_plane_lowres
results: parsing output: 8/ for test: gem_render_copy
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: kms_cursor_legacy
results: parsing output: 11/ for test: gem_madvise
results: parsing output: 12/ for test: syncobj_timeline
results: parsing output: 13/ for test: kms_flip
results: parsing output: 14/ for test: gem_spin_batch
results: parsing output: 15/ for test: kms_psr
results: parsing output: 16/ for test: kms_plane
results: parsing output: 17/ for test: gem_workarounds
results: parsing output: 18/ for test: kms_psr2_sf
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_rotation_crc
results: parsing output: 21/ for test: kms_chamelium_color
results: parsing output: 22/ for test: kms_content_protection
results: parsing output: 23/ for test: gem_ctx_param
results: parsing output: 24/ for test: syncobj_wait
results: parsing output: 25/ for test: kms_ccs
results: parsing output: 26/ for test: gem_exec_balancer
results: parsing output: 27/ for test: gem_ctx_persistence
results: parsing output: 28/ for test: kms_async_flips
results: parsing output: 29/ for test: kms_plane
results: parsing output: 30/ for test: kms_rotation_crc
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_exec_reloc
results: parsing output: 33/ for test: kms_universal_plane
results: parsing output: 34/ for test: gem_mmap_offset
results: parsing output: 35/ for test: gem_wait
results: parsing output: 36/ for test: gem_create
results: parsing output: 37/ for test: gem_media_fill
results: parsing output: 38/ for test: syncobj_wait
results: parsing output: 39/ for test: kms_psr2_sf
results: parsing output: 40/ for test: gem_create
results: parsing output: 41/ for test: i915_pm_freq_api
results: parsing output: 42/ for test: kms_ccs
results: parsing output: 43/ for test: kms_flip
results: parsing output: 44/ for test: kms_chamelium_edid
results: parsing output: 45/ for test: gem_exec_reloc
results: parsing output: 46/ for test: api_intel_allocator
results: parsing output: 47/ for test: gem_exec_schedule
results: parsing output: 48/ for test: gen7_exec_parse
results: parsing output: 49/ for test: kms_vblank
results: parsing output: 50/ for test: gem_render_copy
results: parsing output: 51/ for test: gem_exec_balancer
results: parsing output: 52/ for test: kms_atomic_interruptible
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gem_exec_params
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: gen3_render_mixed_blits
results: parsing output: 57/ for test: kms_addfb_basic
results: parsing output: 58/ for test: kms_flip
results: parsing output: 59/ for test: kms_dsc
results: parsing output: 60/ for test: i915_drm_fdinfo
results: parsing output: 61/ for test: perf_pmu
results: parsing output: 62/ for test: kms_psr
results: parsing output: 63/ for test: perf
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: syncobj_timeline
results: parsing output: 66/ for test: kms_properties
results: parsing output: 67/ for test: perf
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_big_fb
results: parsing output: 70/ for test: kms_invalid_mode
results: parsing output: 71/ for test: syncobj_timeline
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_force_connector_basic
results: parsing output: 74/ for test: kms_plane_alpha_blend
results: parsing output: 75/ for test: kms_flip_scaled_crc
results: parsing output: 76/ for test: gem_exec_schedule
results: parsing output: 77/ for test: gem_busy
results: parsing output: 78/ for test: kms_plane_scaling
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: gem_render_copy_redux
results: parsing output: 81/ for test: gem_userptr_blits
results: parsing output: 82/ for test: syncobj_wait
results: parsing output: 83/ for test: kms_psr
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: tools_test
results: parsing output: 87/ for test: kms_pm_rpm
results: parsing output: 88/ for test: kms_hdr
results: parsing output: 89/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 90/ for test: gem_userptr_blits
results: parsing output: 91/ for test: gem_exec_reloc
results: parsing output: 92/ for test: kms_color
results: parsing output: 93/ for test: gem_exec_create
results: parsing output: 94/ for test: i915_pm_rc6_residency
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_atomic_transition
results: parsing output: 97/ for test: perf
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: i915_pm_rps
results: parsing output: 100/ for test: kms_cursor_legacy
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gem_lmem_swapping
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: sysfs_heartbeat_interval
results: parsing output: 105/ for test: kms_cursor_crc
results: parsing output: 106/ for test: kms_ccs
results: parsing output: 107/ for test: drm_read
results: parsing output: 108/ for test: kms_prime
results: parsing output: 109/ for test: kms_cursor_legacy
results: parsing output: 110/ for test: kms_psr
results: parsing output: 111/ for test: gem_ctx_persistence
results: parsing output: 112/ for test: kms_cursor_edge_walk
results: parsing output: 113/ for test: gem_exec_fence
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: kms_cursor_crc
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: api_intel_bb
results: parsing output: 118/ for test: gem_exec_reloc
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: kms_chamelium_hpd
results: parsing output: 122/ for test: gem_exec_async
results: parsing output: 123/ for test: prime_self_import
results: parsing output: 124/ for test: perf_pmu
results: parsing output: 125/ for test: kms_flip_scaled_crc
results: parsing output: 126/ for test: kms_psr
results: parsing output: 127/ for test: kms_ccs
results: parsing output: 128/ for test: kms_lease
results: parsing output: 129/ for test: kms_big_fb
results: parsing output: 130/ for test: gem_sync
results: parsing output: 131/ for test: syncobj_wait
results: parsing output: 132/ for test: gem_exec_create
Done.