[55.587575] Initializing watchdogs
[55.587623]   /dev/watchdog0
[55.602404] [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]
[55.607089] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[55.609455] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[55.612701] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[55.753205] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[62.621658] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.916s)
[62.778589] [002/133] (953s left) gem_mmap_wc (bad-offset)
[62.842727] Subtest bad-offset: SKIP (0.000s)
[62.894331] [003/133] (953s left) kms_psr (fbc-pr-suspend)
[62.982805] Starting subtest: fbc-pr-suspend
[62.986891] Subtest fbc-pr-suspend: SKIP (0.000s)
[63.064467] [004/133] (953s left) api_intel_allocator (standalone)
[63.133095] Starting subtest: standalone
[63.150478] Subtest standalone: SUCCESS (0.019s)
[63.274887] [005/133] (952s left) syncobj_basic (bad-handle-to-fd)
[63.344605] Starting subtest: bad-handle-to-fd
[63.347042] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[63.449892] [006/133] (952s left) gem_exec_schedule (semaphore-codependency)
[63.520268] Starting subtest: semaphore-codependency
[63.529284] Subtest semaphore-codependency: SUCCESS (0.015s)
[63.865959] [007/133] (952s left) kms_big_fb (4-tiled-addfb-size-overflow)
[63.989186] Starting subtest: 4-tiled-addfb-size-overflow
[63.991112] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[64.083441] [008/133] (952s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[64.151060] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[64.207163] [009/133] (952s left) kms_psr (pr-sprite-mmap-cpu)
[64.300641] Starting subtest: pr-sprite-mmap-cpu
[64.305164] Subtest pr-sprite-mmap-cpu: SKIP (0.000s)
[64.383135] [010/133] (952s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[64.504936] Starting subtest: short-flip-before-cursor-toggle
[65.449131] Subtest short-flip-before-cursor-toggle: SUCCESS (0.947s)
[66.248781] [011/133] (950s left) gem_mmap_gtt (basic)
[66.311125] Subtest basic: SKIP (0.000s)
[66.374997] [012/133] (950s left) kms_atomic_interruptible (universal-setplane-cursor)
[66.477932] Starting subtest: universal-setplane-cursor
[66.480206] Starting dynamic subtest: pipe-A-eDP-1
[73.854942] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.387s)
[73.857385] Subtest universal-setplane-cursor: SUCCESS (7.388s)
[74.708847] [013/133] (941s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[74.768845] Starting subtest: invalid-signal-one-illegal-handle
[74.771173] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[74.874742] [014/133] (941s left) kms_psr (psr-sprite-mmap-cpu)
[74.963793] Starting subtest: psr-sprite-mmap-cpu
[74.966018] Starting dynamic subtest: eDP-1
[76.726081] Dynamic subtest eDP-1: SUCCESS (1.763s)
[76.728602] Subtest psr-sprite-mmap-cpu: SUCCESS (1.763s)
[77.573837] [015/133] (939s left) device_reset (unbind-cold-reset-rebind)
[77.632414] Starting subtest: unbind-cold-reset-rebind
[77.636713] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[77.713198] [016/133] (938s left) syncobj_eventfd (invalid-illegal-eventfd)
[77.764732] Starting subtest: invalid-illegal-eventfd
[77.766999] Subtest invalid-illegal-eventfd: SUCCESS (0.000s)
[77.854615] [017/133] (938s left) kms_content_protection (dp-mst-lic-type-1)
[77.994587] Starting subtest: dp-mst-lic-type-1
[77.999246] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[78.117235] [018/133] (938s left) kms_vblank (query-forked)
[78.202602] Starting subtest: query-forked
[78.204950] Starting dynamic subtest: pipe-A-eDP-1
[80.028603] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.825s)
[80.043073] Starting dynamic subtest: pipe-D-eDP-1
[82.570799] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.541s)
[82.573066] Subtest query-forked: SUCCESS (4.368s)
[83.438402] [019/133] (933s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[83.539390] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu
[87.814993] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.278s)
[88.937425] [020/133] (927s left) gem_reg_read (bad-register)
[88.998070] Starting subtest: bad-register
[89.000639] Subtest bad-register: SUCCESS (0.000s)
[89.111434] [021/133] (927s left) perf (oa-formats)
[89.256902] Starting subtest: oa-formats
[89.259006] Starting dynamic subtest: 0-rcs0
[89.270979] Dynamic subtest 0-rcs0: SUCCESS (0.015s)
[89.280288] Starting dynamic subtest: 1-vecs0
[89.292644] Dynamic subtest 1-vecs0: SUCCESS (0.021s)
[89.294999] Subtest oa-formats: SUCCESS (0.037s)
[89.341725] [022/133] (927s left) gem_ctx_persistence (hang)
[89.404897] Starting subtest: hang
[89.409869] Subtest hang: SKIP (0.000s)
[89.516181] [023/133] (927s left) gem_exec_gttfill (multigpu-basic)
[89.680566] Starting subtest: multigpu-basic
[102.381235] Subtest multigpu-basic: SUCCESS (12.702s)
[102.428423] [024/133] (914s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[102.583268] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[102.587270] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[102.693800] [025/133] (914s left) kms_chamelium_hpd (vga-hpd-for-each-pipe)
[103.090198] Subtest vga-hpd-for-each-pipe: SKIP (0.000s)
[103.941629] [026/133] (913s left) kms_plane_multiple (tiling-x)
[104.030370] Starting subtest: tiling-x
[104.032645] Starting dynamic subtest: pipe-A-eDP-1
[107.690428] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.660s)
[107.699152] Starting dynamic subtest: pipe-B-eDP-1
[112.126069] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.435s)
[112.135063] Starting dynamic subtest: pipe-C-eDP-1
[116.445963] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.318s)
[116.455868] Starting dynamic subtest: pipe-D-eDP-1
[120.790630] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.342s)
[120.792925] Subtest tiling-x: SUCCESS (16.759s)
[121.616121] [027/133] (895s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[121.849316] Starting subtest: cursor-rapid-movement-128x42
[121.896791] Subtest cursor-rapid-movement-128x42: SKIP (0.043s)
[122.106482] [028/133] (895s left) syncobj_wait (reset-during-wait-for-submit)
[122.165599] Starting subtest: reset-during-wait-for-submit
[122.268472] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[122.344464] [029/133] (894s left) gem_linear_blits (interruptible)
[122.501882] Starting subtest: interruptible
[126.849627] Subtest interruptible: SUCCESS (4.350s)
[126.990779] [030/133] (890s left) syncobj_wait (wait-all-for-submit-snapshot)
[127.094911] Starting subtest: wait-all-for-submit-snapshot
[127.176868] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[127.274538] [031/133] (890s left) kms_lease (lease-invalid-connector)
[127.373800] Starting subtest: lease-invalid-connector
[127.376106] Starting dynamic subtest: pipe-A-eDP-1
[127.378259] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[127.387086] Starting dynamic subtest: pipe-B-eDP-1
[127.389304] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[127.397516] Starting dynamic subtest: pipe-C-eDP-1
[127.399633] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[127.407780] Starting dynamic subtest: pipe-D-eDP-1
[127.409599] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[127.411406] Subtest lease-invalid-connector: SUCCESS (0.004s)
[127.446117] [032/133] (889s left) sysfs_timeslice_duration (timeout)
[127.506407] Starting subtest: timeout
[127.508661] Starting dynamic subtest: vecs0
[137.273521] Dynamic subtest vecs0: SUCCESS (9.763s)
[137.285667] Starting dynamic subtest: ccs0
[138.627554] Dynamic subtest ccs0: SUCCESS (1.354s)
[138.639066] Starting dynamic subtest: vcs0
[148.280924] Dynamic subtest vcs0: SUCCESS (9.651s)
[148.294123] Starting dynamic subtest: bcs0
[148.936354] Dynamic subtest bcs0: SUCCESS (0.655s)
[148.946890] Starting dynamic subtest: rcs0
[150.201723] Dynamic subtest rcs0: SUCCESS (1.263s)
[150.212951] Starting dynamic subtest: vcs1
[160.317688] Dynamic subtest vcs1: SUCCESS (10.113s)
[160.320060] Subtest timeout: SUCCESS (32.809s)
[160.395749] [033/133] (857s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[160.500088] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[160.502412] Starting dynamic subtest: pipe-A-eDP-1
[160.525388] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[160.537041] Starting dynamic subtest: pipe-B-eDP-1
[160.559063] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[160.567606] Starting dynamic subtest: pipe-C-eDP-1
[160.589305] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[160.597537] Starting dynamic subtest: pipe-D-eDP-1
[160.619729] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[160.623827] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.007s)
[162.683475] [034/133] (854s left) kms_prop_blob (blob-prop-core)
[162.741984] Starting subtest: blob-prop-core
[162.743913] Subtest blob-prop-core: SUCCESS (0.000s)
[162.821863] [035/133] (854s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[162.916966] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[162.921269] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[163.021472] [036/133] (854s left) kms_atomic (plane-invalid-params)
[163.111291] Starting subtest: plane-invalid-params
[163.113440] Starting dynamic subtest: pipe-A-eDP-1
[163.544417] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.433s)
[163.546776] Subtest plane-invalid-params: SUCCESS (0.435s)
[164.418299] [037/133] (853s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[164.515020] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[164.519226] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[164.594914] [038/133] (853s left) kms_properties (invalid-properties-atomic)
[164.677632] Starting subtest: invalid-properties-atomic
[164.996109] Subtest invalid-properties-atomic: SUCCESS (0.318s)
[165.068050] [039/133] (852s left) i915_query (hwconfig_table)
[165.122932] Starting subtest: hwconfig_table
[165.424609] Subtest hwconfig_table: SUCCESS (0.001s)
[165.461842] [040/133] (852s left) kms_plane (pixel-format-linear-modifier)
[165.565078] Starting subtest: pixel-format-linear-modifier
[165.590903] Starting dynamic subtest: pipe-A-plane-0
[169.046431] Dynamic subtest pipe-A-plane-0: SUCCESS (3.455s)
[169.060216] Starting dynamic subtest: pipe-A-plane-3
[170.734900] Dynamic subtest pipe-A-plane-3: SUCCESS (1.687s)
[170.745855] Starting dynamic subtest: pipe-A-plane-5
[170.946046] Dynamic subtest pipe-A-plane-5: SUCCESS (0.210s)
[172.099065] Starting dynamic subtest: pipe-B-plane-0
[175.699466] Dynamic subtest pipe-B-plane-0: SUCCESS (3.611s)
[175.707735] Starting dynamic subtest: pipe-B-plane-3
[177.422155] Dynamic subtest pipe-B-plane-3: SUCCESS (1.722s)
[177.432061] Starting dynamic subtest: pipe-B-plane-5
[177.633080] Dynamic subtest pipe-B-plane-5: SUCCESS (0.210s)
[177.948284] Subtest pixel-format-linear-modifier: SUCCESS (12.383s)
[178.767015] [041/133] (838s left) drm_read (invalid-buffer)
[178.916068] Starting subtest: invalid-buffer
[178.918445] Subtest invalid-buffer: SUCCESS (0.000s)
[179.131599] [042/133] (838s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[179.185293] Starting subtest: etime-multi-wait-for-submit-submitted
[179.288361] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.103s)
[179.362011] [043/133] (838s left) i915_drm_fdinfo (busy)
[179.409493] Starting subtest: busy
[179.411385] Starting dynamic subtest: rcs0
[179.431979] Dynamic subtest rcs0: SKIP (0.022s)
[179.440590] Starting dynamic subtest: bcs0
[179.447825] Dynamic subtest bcs0: SKIP (0.013s)
[179.456263] Starting dynamic subtest: vcs0
[179.460645] Dynamic subtest vcs0: SKIP (0.000s)
[179.469182] Starting dynamic subtest: vcs1
[179.473291] Dynamic subtest vcs1: SKIP (0.000s)
[179.481465] Starting dynamic subtest: vecs0
[179.485691] Dynamic subtest vecs0: SKIP (0.000s)
[179.493962] Starting dynamic subtest: ccs0
[179.498144] Dynamic subtest ccs0: SKIP (0.000s)
[179.502259] Subtest busy: SKIP (0.039s)
[179.537045] [044/133] (838s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[179.647444] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[186.511460] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.866s)
[186.647583] [045/133] (831s left) gem_create (create-ext-placement-sanity-check)
[186.811203] Starting subtest: create-ext-placement-sanity-check
[186.817495] Subtest create-ext-placement-sanity-check: SUCCESS (0.006s)
[186.927315] [046/133] (831s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[187.032491] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[194.392363] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.365s)
[194.528350] [047/133] (823s left) gem_lmem_swapping (heavy-verify-random-ccs)
[194.570875] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[194.611876] [048/133] (823s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[194.707222] Starting subtest: plane-lut1d-ctm3x4
[194.856354] Starting dynamic subtest: pipe-A-plane-0
[195.056076] Dynamic subtest pipe-A-plane-0: SUCCESS (0.200s)
[195.066778] Starting dynamic subtest: pipe-A-plane-1
[195.222835] Dynamic subtest pipe-A-plane-1: SUCCESS (0.166s)
[195.231509] Starting dynamic subtest: pipe-A-plane-2
[195.388869] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[196.559644] Starting dynamic subtest: pipe-B-plane-0
[196.718401] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s)
[196.727697] Starting dynamic subtest: pipe-B-plane-1
[196.890839] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s)
[196.899896] Starting dynamic subtest: pipe-B-plane-2
[197.040591] Dynamic subtest pipe-B-plane-2: SUCCESS (0.155s)
[198.301861] Starting dynamic subtest: pipe-C-plane-0
[198.458822] Dynamic subtest pipe-C-plane-0: SUCCESS (0.166s)
[198.468304] Starting dynamic subtest: pipe-C-plane-1
[198.625328] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s)
[198.637590] Starting dynamic subtest: pipe-C-plane-2
[198.792206] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s)
[200.004244] Starting dynamic subtest: pipe-D-plane-0
[200.151764] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s)
[200.160887] Starting dynamic subtest: pipe-D-plane-1
[200.307038] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s)
[200.316206] Starting dynamic subtest: pipe-D-plane-2
[200.463053] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[200.754182] Subtest plane-lut1d-ctm3x4: SUCCESS (6.046s)
[201.583303] [049/133] (816s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[201.682863] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[208.279355] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.600s)
[208.405132] [050/133] (809s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[208.469396] Starting subtest: wait-all-for-submit-delayed-submit
[208.571066] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[208.650708] [051/133] (809s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[208.752526] Starting subtest: y-tiled-32bpp-rotate-270
[208.756681] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s)
[208.835048] [052/133] (809s left) fbdev (unaligned-write)
[208.876407] Starting subtest: unaligned-write
[208.979684] Subtest unaligned-write: SUCCESS (0.102s)
[209.040504] [053/133] (809s left) gem_mmap_gtt (coherency)
[209.089688] Subtest coherency: SKIP (0.000s)
[209.152126] [054/133] (809s left) kms_flip (basic-flip-vs-wf_vblank)
[209.258084] Starting subtest: basic-flip-vs-wf_vblank
[209.260416] Starting dynamic subtest: A-eDP1
[211.154628] Dynamic subtest A-eDP1: SUCCESS (1.898s)
[211.166444] Starting dynamic subtest: B-eDP1
[213.079557] Dynamic subtest B-eDP1: SUCCESS (1.923s)
[213.091018] Starting dynamic subtest: C-eDP1
[215.000881] Dynamic subtest C-eDP1: SUCCESS (1.919s)
[215.011885] Starting dynamic subtest: D-eDP1
[216.932512] Dynamic subtest D-eDP1: SUCCESS (1.930s)
[216.937614] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.682s)
[218.171811] [055/133] (800s left) gen9_exec_parse (batch-zero-length)
[218.241072] Subtest batch-zero-length: SKIP (0.000s)
[218.309208] [056/133] (800s left) kms_flip (wf_vblank-ts-check-interruptible)
[218.399441] Starting subtest: wf_vblank-ts-check-interruptible
[218.401784] Starting dynamic subtest: A-eDP1
[227.317161] Dynamic subtest A-eDP1: SUCCESS (8.917s)
[227.327565] Starting dynamic subtest: B-eDP1
[236.233440] Dynamic subtest B-eDP1: SUCCESS (8.915s)
[236.247427] Starting dynamic subtest: C-eDP1
[245.161387] Dynamic subtest C-eDP1: SUCCESS (8.925s)
[245.175148] Starting dynamic subtest: D-eDP1
[254.095246] Dynamic subtest D-eDP1: SUCCESS (8.931s)
[254.101114] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.701s)
[255.341841] [057/133] (763s left) kms_sequence (get-busy)
[255.441821] Starting subtest: get-busy
[255.443970] Starting dynamic subtest: pipe-A-eDP-1
[257.384913] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.943s)
[257.396278] Starting dynamic subtest: pipe-B-eDP-1
[260.035074] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.648s)
[260.044329] Starting dynamic subtest: pipe-C-eDP-1
[262.636139] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.599s)
[262.645345] Starting dynamic subtest: pipe-D-eDP-1
[265.174336] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.539s)
[265.176634] Subtest get-busy: SUCCESS (9.734s)
[265.970962] [058/133] (752s left) perf (invalid-oa-format-id)
[266.079823] Starting subtest: invalid-oa-format-id
[266.088937] Subtest invalid-oa-format-id: SUCCESS (0.009s)
[266.127325] [059/133] (752s left) perf_pmu (render-node-busy)
[266.211045] Starting subtest: render-node-busy
[266.213213] Starting dynamic subtest: rcs0
[266.796732] Dynamic subtest rcs0: SUCCESS (0.587s)
[266.810981] Starting dynamic subtest: bcs0
[267.359570] Dynamic subtest bcs0: SUCCESS (0.559s)
[267.371168] Starting dynamic subtest: vcs0
[269.308439] Dynamic subtest vcs0: SUCCESS (1.945s)
[269.320610] Starting dynamic subtest: vcs1
[271.293060] Dynamic subtest vcs1: SUCCESS (1.982s)
[271.304938] Starting dynamic subtest: vecs0
[273.277077] Dynamic subtest vecs0: SUCCESS (1.981s)
[273.289227] Starting dynamic subtest: ccs0
[273.838644] Dynamic subtest ccs0: SUCCESS (0.560s)
[273.841210] Subtest render-node-busy: SUCCESS (7.632s)
[273.927201] [060/133] (744s left) kms_cursor_crc (cursor-sliding-64x21)
[274.130502] Starting subtest: cursor-sliding-64x21
[274.180261] Subtest cursor-sliding-64x21: SKIP (0.045s)
[274.407481] [061/133] (744s left) gem_exec_await (wide-contexts)
[274.649219] Starting subtest: wide-contexts
[298.007940] Subtest wide-contexts: SUCCESS (23.356s)
[298.211038] [FACT gem_exec_await (wide-contexts)] new: kernel.kmod_is_loaded.vgem: true
[298.215368] [062/133] (720s left) gem_eio (throttle)
[298.502522] Starting subtest: throttle
[298.872926] Subtest throttle: SUCCESS (0.369s)
[298.996460] [063/133] (719s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[299.093887] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[302.641516] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.550s)
[303.781741] [064/133] (714s left) kms_chamelium_frames (dp-crc-multiple)
[304.165770] Subtest dp-crc-multiple: SKIP (0.000s)
[304.983811] [065/133] (713s left) syncobj_wait (multi-wait-all-signaled)
[305.043852] Starting subtest: multi-wait-all-signaled
[305.046303] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[305.111262] [066/133] (713s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[305.203606] Starting subtest: plane-scaler-unity-scaling-with-rotation
[305.205524] Starting dynamic subtest: pipe-A
[305.430075] Dynamic subtest pipe-A: SUCCESS (0.228s)
[305.442927] Starting dynamic subtest: pipe-B
[306.695389] Dynamic subtest pipe-B: SUCCESS (1.265s)
[306.705602] Starting dynamic subtest: pipe-C
[308.028988] Dynamic subtest pipe-C: SUCCESS (1.333s)
[308.039403] Starting dynamic subtest: pipe-D
[309.389346] Dynamic subtest pipe-D: SUCCESS (1.359s)
[309.391593] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.188s)
[310.541594] [067/133] (708s left) gem_exec_balancer (invalid-balancer)
[310.606905] Starting subtest: invalid-balancer
[311.535905] Subtest invalid-balancer: SUCCESS (0.927s)
[311.837968] [068/133] (706s left) kms_cursor_crc (cursor-onscreen-max-size)
[312.174728] Starting subtest: cursor-onscreen-max-size
[312.181091] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[312.291737] [069/133] (706s left) gem_ctx_param (vm)
[312.349833] Starting subtest: vm
[312.425204] Subtest vm: SUCCESS (0.075s)
[312.548879] [070/133] (706s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[312.629624] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[312.631723] Starting dynamic subtest: pipe-A
[312.655062] Dynamic subtest pipe-A: SKIP (0.021s)
[312.665283] Starting dynamic subtest: pipe-B
[312.687205] Dynamic subtest pipe-B: SKIP (0.031s)
[312.696831] Starting dynamic subtest: pipe-C
[312.720998] Dynamic subtest pipe-C: SKIP (0.033s)
[312.730847] Starting dynamic subtest: pipe-D
[312.755579] Dynamic subtest pipe-D: SKIP (0.033s)
[312.759519] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SKIP (0.121s)
[312.851424] [071/133] (706s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[312.958182] Starting subtest: 2x-long-flip-vs-cursor-atomic
[312.961908] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s)
[313.107548] [072/133] (705s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[313.198088] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[322.563304] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.366s)
[322.677750] [073/133] (696s left) kms_flip (basic-flip-vs-modeset)
[322.770362] Starting subtest: basic-flip-vs-modeset
[322.772739] Starting dynamic subtest: A-eDP1
[325.370748] Dynamic subtest A-eDP1: SUCCESS (2.601s)
[325.381852] Starting dynamic subtest: B-eDP1
[327.537085] Dynamic subtest B-eDP1: SUCCESS (2.164s)
[327.547617] Starting dynamic subtest: C-eDP1
[329.692441] Dynamic subtest C-eDP1: SUCCESS (2.153s)
[329.703365] Starting dynamic subtest: D-eDP1
[331.769957] Dynamic subtest D-eDP1: SUCCESS (2.078s)
[331.772437] Subtest basic-flip-vs-modeset: SUCCESS (9.005s)
[332.581198] [074/133] (686s left) kms_psr (psr-cursor-mmap-gtt)
[332.684977] Starting subtest: psr-cursor-mmap-gtt
[332.687233] Starting dynamic subtest: eDP-1
[334.376075] Dynamic subtest eDP-1: SUCCESS (1.692s)
[334.378426] Subtest psr-cursor-mmap-gtt: SUCCESS (1.693s)
[335.251362] [075/133] (683s left) i915_pm_rpm (sysfs-read)
[337.383730] Starting subtest: sysfs-read
[338.534464] Subtest sysfs-read: SUCCESS (1.149s)
[338.909480] [076/133] (680s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[339.011739] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[339.016250] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[339.121241] [077/133] (680s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[339.216328] Starting subtest: fbc-psr2-cursor-plane-update-sf
[339.218439] Starting dynamic subtest: pipe-A-eDP-1
[339.290095] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[339.301045] Starting dynamic subtest: pipe-B-eDP-1
[340.470321] Dynamic subtest pipe-B-eDP-1: SKIP (1.177s)
[340.474865] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.258s)
[341.661397] [078/133] (677s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[341.768895] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[348.852913] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.086s)
[348.957930] [079/133] (670s left) core_auth (getclient-master-drop)
[349.010287] Starting subtest: getclient-master-drop
[349.031787] Subtest getclient-master-drop: SUCCESS (0.022s)
[349.131158] [080/133] (670s left) kms_pm_dc (dc6-dpms)
[350.226646] Starting subtest: dc6-dpms
[352.266086] Subtest dc6-dpms: SUCCESS (2.038s)
[352.372774] [081/133] (667s left) kms_async_flips (alternate-sync-async-flip-atomic)
[352.470056] Starting subtest: alternate-sync-async-flip-atomic
[352.842421] Starting dynamic subtest: pipe-A-eDP-1
[355.605954] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.765s)
[355.985472] Starting dynamic subtest: pipe-B-eDP-1
[358.727568] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.750s)
[359.108069] Starting dynamic subtest: pipe-C-eDP-1
[361.857121] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.753s)
[362.220029] Starting dynamic subtest: pipe-D-eDP-1
[364.986783] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.777s)
[364.988847] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.519s)
[366.156634] [082/133] (653s left) gem_exec_reloc (basic-write-cpu-noreloc)
[366.229376] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[366.316241] [083/133] (653s left) gem_exec_nop (basic-series)
[366.392200] Starting subtest: basic-series
[382.272878] Subtest basic-series: SUCCESS (15.886s)
[382.509027] [084/133] (637s left) kms_invalid_mode (bad-hsync-start)
[382.621444] Starting subtest: bad-hsync-start
[382.623811] Starting dynamic subtest: pipe-A-eDP-1
[382.901748] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[382.911912] Starting dynamic subtest: pipe-B-eDP-1
[382.914055] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[382.923049] Starting dynamic subtest: pipe-C-eDP-1
[382.925044] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[382.934771] Starting dynamic subtest: pipe-D-eDP-1
[382.936981] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[382.939203] Subtest bad-hsync-start: SUCCESS (0.291s)
[383.790079] [085/133] (635s left) kms_dirtyfb (drrs-dirtyfb-ioctl)
[383.891465] Starting subtest: drrs-dirtyfb-ioctl
[383.904386] Subtest drrs-dirtyfb-ioctl: SKIP (0.001s)
[383.992947] [086/133] (635s left) syncobj_wait (single-wait-all-submitted)
[384.047591] Starting subtest: single-wait-all-submitted
[384.153260] Subtest single-wait-all-submitted: SUCCESS (0.105s)
[384.249391] [087/133] (635s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[384.345068] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[384.347292] Starting dynamic subtest: pipe-A-eDP-1
[384.356255] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[384.371284] Starting dynamic subtest: pipe-B-eDP-1
[384.379735] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[384.389232] Starting dynamic subtest: pipe-C-eDP-1
[384.397409] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[384.407056] Starting dynamic subtest: pipe-D-eDP-1
[384.415415] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[384.419344] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[386.642157] [088/133] (633s left) syncobj_wait (single-wait-signaled)
[386.701694] Starting subtest: single-wait-signaled
[386.704170] Subtest single-wait-signaled: SUCCESS (0.000s)
[386.812991] [089/133] (632s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[386.915315] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[386.919605] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[387.019897] [090/133] (632s left) gem_mmap_offset (mmap-boundaries)
[387.071123] Starting subtest: mmap-boundaries
[387.073351] Starting dynamic subtest: smem0
[387.355924] Dynamic subtest smem0: SUCCESS (0.284s)
[387.358829] Subtest mmap-boundaries: SUCCESS (0.285s)
[387.481966] [091/133] (632s left) gem_exec_schedule (wide)
[387.657328] Starting subtest: wide
[387.659767] Starting dynamic subtest: rcs0
[398.203273] Dynamic subtest rcs0: SUCCESS (10.545s)
[398.216671] Starting dynamic subtest: vcs0
[408.371499] Dynamic subtest vcs0: SUCCESS (10.167s)
[408.384730] Starting dynamic subtest: vcs1
[418.882406] Dynamic subtest vcs1: SUCCESS (10.509s)
[418.892397] Starting dynamic subtest: vecs0
[429.924320] Dynamic subtest vecs0: SUCCESS (11.040s)
[429.936068] Starting dynamic subtest: ccs0
[442.997376] Dynamic subtest ccs0: SUCCESS (13.071s)
[443.000053] Subtest wide: SUCCESS (55.339s)
[446.532459] [092/133] (573s left) gem_exec_balancer (sequential)
[446.613975] Starting subtest: sequential
[449.712902] Subtest sequential: SUCCESS (3.099s)
[450.021543] [093/133] (569s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[450.129084] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[450.133063] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[450.236844] [094/133] (569s left) i915_query (query-garbage)
[450.301069] Starting subtest: query-garbage
[450.303193] Subtest query-garbage: SUCCESS (0.000s)
[450.404415] [095/133] (569s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[450.503322] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[450.507408] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[450.584423] [096/133] (569s left) gem_userptr_blits (invalid-mmap-offset-unsync)
[450.670532] Subtest invalid-mmap-offset-unsync: SKIP (0.000s)
[450.814223] [097/133] (569s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[450.929224] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[451.809728] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.881s)
[451.974799] [098/133] (568s left) syncobj_timeline (reset-signaled)
[452.030670] Starting subtest: reset-signaled
[452.032617] Subtest reset-signaled: SUCCESS (0.000s)
[452.127919] [099/133] (568s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[452.225966] Starting subtest: primary-y-tiled-reflect-x-180
[452.285726] Subtest primary-y-tiled-reflect-x-180: SKIP (0.059s)
[452.389147] [100/133] (567s left) template (b)
[452.452114] Starting subtest: B
[452.454411] Subtest B: SUCCESS (0.000s)
[452.551844] [101/133] (567s left) kms_draw_crc (draw-method-blt)
[452.643280] Starting subtest: draw-method-blt
[452.645149] Starting dynamic subtest: xrgb8888-untiled
[452.876637] Dynamic subtest xrgb8888-untiled: SUCCESS (0.235s)
[452.887871] Starting dynamic subtest: rgb565-untiled
[453.121200] Dynamic subtest rgb565-untiled: SUCCESS (0.243s)
[453.133260] Starting dynamic subtest: xrgb2101010-untiled
[453.332485] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.209s)
[453.342589] Starting dynamic subtest: xbgr16161616f-untiled
[453.666046] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.333s)
[453.678661] Starting dynamic subtest: xrgb8888-xtiled
[453.855117] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.186s)
[453.867627] Starting dynamic subtest: rgb565-xtiled
[454.021543] Dynamic subtest rgb565-xtiled: SUCCESS (0.164s)
[454.031166] Starting dynamic subtest: xrgb2101010-xtiled
[454.132612] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s)
[454.142333] Starting dynamic subtest: xbgr16161616f-xtiled
[454.232681] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.099s)
[454.242488] Starting dynamic subtest: xrgb8888-4tiled
[454.354625] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.121s)
[454.364545] Starting dynamic subtest: rgb565-4tiled
[454.465886] Dynamic subtest rgb565-4tiled: SUCCESS (0.110s)
[454.475711] Starting dynamic subtest: xrgb2101010-4tiled
[454.565805] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.099s)
[454.575823] Starting dynamic subtest: xbgr16161616f-4tiled
[454.677078] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.110s)
[454.678919] Subtest draw-method-blt: SUCCESS (2.036s)
[454.806910] [102/133] (565s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[454.906932] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[454.910721] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[455.012991] [103/133] (565s left) prime_self_import (export-vs-gem_close-race)
[455.051926] Starting subtest: export-vs-gem_close-race
[460.132307] Subtest export-vs-gem_close-race: SUCCESS (5.083s)
[460.211494] [104/133] (560s left) gem_lmem_swapping (random)
[460.253625] Subtest random: SKIP (0.000s)
[460.297771] [105/133] (560s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs)
[460.414874] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs
[460.417106] Starting dynamic subtest: pipe-A-eDP-1
[460.439349] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[460.449959] Starting dynamic subtest: pipe-B-eDP-1
[460.471643] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[460.481807] Starting dynamic subtest: pipe-C-eDP-1
[460.503574] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[460.513532] Starting dynamic subtest: pipe-D-eDP-1
[460.535751] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[460.539879] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[462.604972] [106/133] (557s left) kms_chamelium_audio (hdmi-audio-edid)
[462.978291] Subtest hdmi-audio-edid: SKIP (0.000s)
[463.804117] [107/133] (556s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[463.862771] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[463.867239] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[464.045715] [108/133] (556s left) gem_flink_basic (double-flink)
[464.100874] Starting subtest: double-flink
[464.102818] Subtest double-flink: SUCCESS (0.000s)
[464.206449] [109/133] (556s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[464.287806] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[464.290091] Starting dynamic subtest: pipe-A-default-mode
[467.067240] Dynamic subtest pipe-A-default-mode: SUCCESS (2.778s)
[467.069537] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.780s)
[467.931745] [110/133] (552s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[468.024616] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[468.848440] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.826s)
[469.021579] [111/133] (551s left) gem_ctx_shared (q-in-order)
[469.083047] Starting subtest: Q-in-order
[469.085363] Starting dynamic subtest: rcs0
[469.201421] Dynamic subtest rcs0: SUCCESS (0.117s)
[469.218984] Starting dynamic subtest: vcs0
[469.294507] Dynamic subtest vcs0: SUCCESS (0.093s)
[469.314503] Starting dynamic subtest: vcs1
[469.380259] Dynamic subtest vcs1: SUCCESS (0.085s)
[469.396341] Starting dynamic subtest: vecs0
[469.459265] Dynamic subtest vecs0: SUCCESS (0.078s)
[469.477482] Starting dynamic subtest: ccs0
[469.553224] Dynamic subtest ccs0: SUCCESS (0.093s)
[469.555704] Subtest Q-in-order: SUCCESS (0.471s)
[471.375341] [112/133] (549s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[471.475056] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[471.479412] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[471.563254] [113/133] (549s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[471.653733] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[471.657965] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[471.727694] [114/133] (549s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[471.829317] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[471.833693] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[471.933419] [115/133] (548s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[472.070270] Starting subtest: cursorB-vs-flipA-legacy
[472.074564] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[472.214785] [116/133] (548s left) kms_psr (fbc-psr-cursor-blt)
[472.298736] Starting subtest: fbc-psr-cursor-blt
[472.300998] Starting dynamic subtest: eDP-1
[472.305074] Dynamic subtest eDP-1: SKIP (0.000s)
[472.309143] Subtest fbc-psr-cursor-blt: SKIP (0.001s)
[472.372508] [117/133] (548s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[472.463522] Starting subtest: read-crc-frame-sequence
[472.465162] Starting dynamic subtest: pipe-A-eDP-1
[473.183930] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.719s)
[473.194360] Starting dynamic subtest: pipe-B-eDP-1
[474.527222] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.342s)
[474.539959] Starting dynamic subtest: pipe-C-eDP-1
[475.837674] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.309s)
[475.849193] Starting dynamic subtest: pipe-D-eDP-1
[477.162053] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.325s)
[477.164363] Subtest read-crc-frame-sequence: SUCCESS (4.701s)
[477.990184] [118/133] (543s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[478.105614] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[478.109825] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[478.213570] [119/133] (542s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[478.311174] Starting subtest: yf-tiled-8bpp-rotate-90
[478.315196] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[478.403915] [120/133] (542s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[478.526218] Starting subtest: cursor-vs-flip-varying-size
[509.783839] Subtest cursor-vs-flip-varying-size: SUCCESS (31.256s)
[510.608229] [121/133] (510s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[510.727407] Starting subtest: x-tiled-32bpp-rotate-180
[512.228809] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.501s)
[512.363473] [122/133] (508s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[512.901851] Starting subtest: syncobj-timeline-multiple-ext-nodes
[512.904072] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.004s)
[514.389581] [123/133] (506s left) kms_psr (fbc-pr-cursor-blt)
[514.487378] Starting subtest: fbc-pr-cursor-blt
[514.491626] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[514.566220] [124/133] (506s left) gem_pxp (verify-pxp-stale-buf-optout-execution)
[514.702567] Starting subtest: verify-pxp-stale-buf-optout-execution
[515.763749] Subtest verify-pxp-stale-buf-optout-execution: SUCCESS (1.061s)
[515.878789] [125/133] (505s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[515.972750] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[515.975035] Starting dynamic subtest: pipe-A-eDP-1
[516.254075] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.249s)
[516.266657] Starting dynamic subtest: pipe-B-eDP-1
[517.507536] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.251s)
[517.518195] Starting dynamic subtest: pipe-C-eDP-1
[518.789019] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.283s)
[518.800973] Starting dynamic subtest: pipe-D-eDP-1
[520.043438] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.254s)
[520.045510] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (4.042s)
[521.152781] [126/133] (500s left) perf (gen12-group-concurrent-oa-buffer-read)
[521.276692] Starting subtest: gen12-group-concurrent-oa-buffer-read
[531.317315] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.039s)
[531.387530] [127/133] (490s left) prime_vgem (sync)
[531.465359] Starting subtest: sync
[531.467365] Starting dynamic subtest: rcs0
[531.494466] Dynamic subtest rcs0: SUCCESS (0.032s)
[531.504871] Starting dynamic subtest: bcs0
[531.564529] Dynamic subtest bcs0: SUCCESS (0.069s)
[531.574634] Starting dynamic subtest: vcs0
[531.614101] Dynamic subtest vcs0: SUCCESS (0.048s)
[531.624203] Starting dynamic subtest: vcs1
[531.662172] Dynamic subtest vcs1: SUCCESS (0.047s)
[531.672084] Starting dynamic subtest: vecs0
[531.710751] Dynamic subtest vecs0: SUCCESS (0.047s)
[531.721061] Starting dynamic subtest: ccs0
[531.758740] Dynamic subtest ccs0: SUCCESS (0.048s)
[531.761166] Subtest sync: SUCCESS (0.297s)
[531.883019] [128/133] (489s left) gem_spin_batch (spin-all-new)
[531.948988] Starting subtest: spin-all-new
[531.968527] Subtest spin-all-new: SUCCESS (0.023s)
[533.353793] [129/133] (488s left) i915_hangman (gt-error-state-capture)
[533.426834] Starting subtest: gt-error-state-capture
[533.429143] Starting dynamic subtest: rcs0
[545.244270] Dynamic subtest rcs0: SUCCESS (11.815s)
[545.256875] Starting dynamic subtest: bcs0
[557.275371] Dynamic subtest bcs0: SUCCESS (12.029s)
[557.288240] Starting dynamic subtest: vcs0
[568.219603] Dynamic subtest vcs0: SUCCESS (10.941s)
[568.233050] Starting dynamic subtest: vcs1
[580.188396] Dynamic subtest vcs1: SUCCESS (11.965s)
[580.201304] Starting dynamic subtest: vecs0
[591.194452] Dynamic subtest vecs0: SUCCESS (11.003s)
[591.208761] Starting dynamic subtest: ccs0
[602.268077] Dynamic subtest ccs0: SUCCESS (11.070s)
[602.271085] Subtest gt-error-state-capture: SUCCESS (68.839s)
[602.393837] [130/133] (419s left) kms_prime (d3hot)
[602.486351] Subtest D3hot: SKIP (0.000s)
[602.595072] [131/133] (418s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[602.695546] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[607.396657] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.704s)
[608.550664] [132/133] (413s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[608.673222] Starting subtest: cursorB-vs-flipB-atomic
[608.677608] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[608.848296] [133/133] (412s left) gem_exec_schedule (pi-ringfull)
[609.029856] Starting subtest: pi-ringfull
[609.031983] Starting dynamic subtest: rcs0
[609.055808] Dynamic subtest rcs0: SUCCESS (0.028s)
[609.071084] Starting dynamic subtest: bcs0
[609.084083] Dynamic subtest bcs0: SUCCESS (0.027s)
[609.098786] Starting dynamic subtest: vcs0
[609.112614] Dynamic subtest vcs0: SUCCESS (0.028s)
[609.127578] Starting dynamic subtest: vcs1
[609.139631] Dynamic subtest vcs1: SUCCESS (0.026s)
[609.154585] Starting dynamic subtest: vecs0
[609.167110] Dynamic subtest vecs0: SUCCESS (0.027s)
[609.182247] Starting dynamic subtest: ccs0
[609.194139] Dynamic subtest ccs0: SUCCESS (0.026s)
[609.196350] Subtest pi-ringfull: SUCCESS (0.167s)
[609.419706] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_mmap_wc
results: parsing output: 2/ for test: kms_psr
results: parsing output: 3/ for test: api_intel_allocator
results: parsing output: 4/ for test: syncobj_basic
results: parsing output: 5/ for test: gem_exec_schedule
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: gem_exec_reloc
results: parsing output: 8/ for test: kms_psr
results: parsing output: 9/ for test: kms_cursor_legacy
results: parsing output: 10/ for test: gem_mmap_gtt
results: parsing output: 11/ for test: kms_atomic_interruptible
results: parsing output: 12/ for test: syncobj_timeline
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: device_reset
results: parsing output: 15/ for test: syncobj_eventfd
results: parsing output: 16/ for test: kms_content_protection
results: parsing output: 17/ for test: kms_vblank
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_reg_read
results: parsing output: 20/ for test: perf
results: parsing output: 21/ for test: gem_ctx_persistence
results: parsing output: 22/ for test: gem_exec_gttfill
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_chamelium_hpd
results: parsing output: 25/ for test: kms_plane_multiple
results: parsing output: 26/ for test: kms_cursor_crc
results: parsing output: 27/ for test: syncobj_wait
results: parsing output: 28/ for test: gem_linear_blits
results: parsing output: 29/ for test: syncobj_wait
results: parsing output: 30/ for test: kms_lease
results: parsing output: 31/ for test: sysfs_timeslice_duration
results: parsing output: 32/ for test: kms_ccs
results: parsing output: 33/ for test: kms_prop_blob
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_atomic
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_properties
results: parsing output: 38/ for test: i915_query
results: parsing output: 39/ for test: kms_plane
results: parsing output: 40/ for test: drm_read
results: parsing output: 41/ for test: syncobj_timeline
results: parsing output: 42/ for test: i915_drm_fdinfo
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: gem_create
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: gem_lmem_swapping
results: parsing output: 47/ for test: kms_color_pipeline
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: syncobj_timeline
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: fbdev
results: parsing output: 52/ for test: gem_mmap_gtt
results: parsing output: 53/ for test: kms_flip
results: parsing output: 54/ for test: gen9_exec_parse
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: kms_sequence
results: parsing output: 57/ for test: perf
results: parsing output: 58/ for test: perf_pmu
results: parsing output: 59/ for test: kms_cursor_crc
results: parsing output: 60/ for test: gem_exec_await
results: parsing output: 61/ for test: gem_eio
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_chamelium_frames
results: parsing output: 64/ for test: syncobj_wait
results: parsing output: 65/ for test: kms_plane_scaling
results: parsing output: 66/ for test: gem_exec_balancer
results: parsing output: 67/ for test: kms_cursor_crc
results: parsing output: 68/ for test: gem_ctx_param
results: parsing output: 69/ for test: kms_plane_scaling
results: parsing output: 70/ for test: kms_cursor_legacy
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_flip
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: i915_pm_rpm
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_psr2_sf
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: core_auth
results: parsing output: 79/ for test: kms_pm_dc
results: parsing output: 80/ for test: kms_async_flips
results: parsing output: 81/ for test: gem_exec_reloc
results: parsing output: 82/ for test: gem_exec_nop
results: parsing output: 83/ for test: kms_invalid_mode
results: parsing output: 84/ for test: kms_dirtyfb
results: parsing output: 85/ for test: syncobj_wait
results: parsing output: 86/ for test: kms_ccs
results: parsing output: 87/ for test: syncobj_wait
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: gem_mmap_offset
results: parsing output: 90/ for test: gem_exec_schedule
results: parsing output: 91/ for test: gem_exec_balancer
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: i915_query
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: gem_userptr_blits
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: syncobj_timeline
results: parsing output: 98/ for test: kms_rotation_crc
results: parsing output: 99/ for test: template
results: parsing output: 100/ for test: kms_draw_crc
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: prime_self_import
results: parsing output: 103/ for test: gem_lmem_swapping
results: parsing output: 104/ for test: kms_ccs
results: parsing output: 105/ for test: kms_chamelium_audio
results: parsing output: 106/ for test: gem_render_copy
results: parsing output: 107/ for test: gem_flink_basic
results: parsing output: 108/ for test: kms_flip_scaled_crc
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: gem_ctx_shared
results: parsing output: 111/ for test: kms_flip_scaled_crc
results: parsing output: 112/ for test: kms_flip_scaled_crc
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: kms_cursor_legacy
results: parsing output: 115/ for test: kms_psr
results: parsing output: 116/ for test: kms_pipe_crc_basic
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_big_fb
results: parsing output: 119/ for test: kms_cursor_legacy
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: gem_exec_fence
results: parsing output: 122/ for test: kms_psr
results: parsing output: 123/ for test: gem_pxp
results: parsing output: 124/ for test: kms_ccs
results: parsing output: 125/ for test: perf
results: parsing output: 126/ for test: prime_vgem
results: parsing output: 127/ for test: gem_spin_batch
results: parsing output: 128/ for test: i915_hangman
results: parsing output: 129/ for test: kms_prime
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_cursor_legacy
results: parsing output: 132/ for test: gem_exec_schedule
Done.