[60.252501] Initializing watchdogs
[60.252545]   /dev/watchdog0
[60.266061] [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.271028] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.273113] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.276606] [001/133] (960s left) gem_pxp (reject-modify-context-protection-on)
[60.436761] Starting subtest: reject-modify-context-protection-on
[60.439326] Subtest reject-modify-context-protection-on: SUCCESS (0.003s)
[60.566023] [002/133] (960s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[60.668680] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[61.041233] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[63.825827] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.739s)
[63.833168] Starting dynamic subtest: pipe-A-eDP-1-4
[66.004423] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.184s)
[66.014236] Starting dynamic subtest: pipe-A-eDP-1-4
[67.957624] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.007s)
[67.968513] Starting dynamic subtest: pipe-A-eDP-1-x
[70.196206] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.189s)
[70.502666] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[73.334849] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.786s)
[73.344781] Starting dynamic subtest: pipe-B-eDP-1-4
[75.506524] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.174s)
[75.518093] Starting dynamic subtest: pipe-B-eDP-1-4
[77.465389] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[77.473555] Starting dynamic subtest: pipe-B-eDP-1-x
[79.643554] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.178s)
[80.017501] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[82.864173] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.801s)
[82.871999] Starting dynamic subtest: pipe-C-eDP-1-4
[84.988296] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s)
[84.995437] Starting dynamic subtest: pipe-C-eDP-1-4
[86.998913] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.010s)
[87.009292] Starting dynamic subtest: pipe-C-eDP-1-x
[89.228268] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s)
[89.554287] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[92.344549] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.796s)
[92.354779] Starting dynamic subtest: pipe-D-eDP-1-4
[94.571086] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s)
[94.581377] Starting dynamic subtest: pipe-D-eDP-1-4
[96.529055] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.010s)
[96.538767] Starting dynamic subtest: pipe-D-eDP-1-x
[98.758940] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s)
[98.761568] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.064s)
[99.925382] [003/133] (920s left) i915_drm_fdinfo (basics)
[99.978890] Starting subtest: basics
[99.981291] Subtest basics: SUCCESS (0.000s)
[100.047254] [004/133] (920s left) kms_content_protection (dp-mst-lic-type-0)
[100.181806] Starting subtest: dp-mst-lic-type-0
[100.186442] Subtest dp-mst-lic-type-0: SKIP (0.000s)
[100.344383] [005/133] (920s left) kms_big_fb (linear-16bpp-rotate-0)
[100.449272] Starting subtest: linear-16bpp-rotate-0
[101.920357] Subtest linear-16bpp-rotate-0: SUCCESS (1.471s)
[102.062121] [006/133] (918s left) syncobj_basic (test-valid-cycle)
[102.133067] Starting subtest: test-valid-cycle
[102.134959] Subtest test-valid-cycle: SUCCESS (0.000s)
[102.266729] [007/133] (918s left) sw_sync (timeline_closed_signaled)
[102.299769] Starting subtest: timeline_closed_signaled
[102.301742] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[102.362188] [008/133] (918s left) api_intel_bb (misplaced-blitter)
[102.424174] Starting subtest: misplaced-blitter
[102.431692] Subtest misplaced-blitter: SUCCESS (0.008s)
[102.565168] [009/133] (918s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[102.665190] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[102.676727] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.010s)
[102.801530] [010/133] (918s left) gem_exec_balancer (full-late-pulse)
[102.870103] Starting subtest: full-late-pulse
[107.714861] Subtest full-late-pulse: SUCCESS (4.844s)
[108.060678] [011/133] (913s left) i915_drm_fdinfo (virtual-busy-idle)
[108.107650] Starting subtest: virtual-busy-idle
[108.112350] Subtest virtual-busy-idle: SKIP (0.000s)
[108.178729] [012/133] (912s left) gem_ctx_bad_destroy (double-destroy)
[108.238526] Starting subtest: double-destroy
[108.240993] Subtest double-destroy: SUCCESS (0.000s)
[108.328927] [013/133] (912s left) kms_plane_cursor (primary)
[108.425831] Starting subtest: primary
[108.430355] Starting dynamic subtest: pipe-A-eDP-1-size-64
[110.887328] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.462s)
[110.913104] Starting dynamic subtest: pipe-A-eDP-1-size-128
[113.455499] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.549s)
[113.480081] Starting dynamic subtest: pipe-A-eDP-1-size-256
[115.945663] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.472s)
[116.258696] Starting dynamic subtest: pipe-B-eDP-1-size-64
[119.399219] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.150s)
[119.423073] Starting dynamic subtest: pipe-B-eDP-1-size-128
[121.967043] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.549s)
[121.991706] Starting dynamic subtest: pipe-B-eDP-1-size-256
[124.501162] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.516s)
[124.802137] Starting dynamic subtest: pipe-C-eDP-1-size-64
[127.639296] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.847s)
[127.664408] Starting dynamic subtest: pipe-C-eDP-1-size-128
[129.783282] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.125s)
[129.809488] Starting dynamic subtest: pipe-C-eDP-1-size-256
[131.895531] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.091s)
[132.226062] Starting dynamic subtest: pipe-D-eDP-1-size-64
[135.102298] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.883s)
[135.128344] Starting dynamic subtest: pipe-D-eDP-1-size-128
[137.269099] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.147s)
[137.296089] Starting dynamic subtest: pipe-D-eDP-1-size-256
[139.469987] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.179s)
[139.774328] Subtest primary: SUCCESS (31.349s)
[140.664948] [014/133] (880s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[140.730653] Starting subtest: rel-constants-invalid-rel-gen5
[140.733043] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[140.859970] [015/133] (880s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[140.960967] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[140.965645] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[142.088328] [016/133] (879s left) syncobj_timeline (single-wait-available-submitted)
[142.148498] Starting subtest: single-wait-available-submitted
[142.150687] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[142.251485] [017/133] (879s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[142.358230] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[149.564299] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.205s)
[149.733877] [018/133] (871s left) gem_ctx_engines (execute-oneforall)
[149.807330] Starting subtest: execute-oneforall
[150.322234] Subtest execute-oneforall: SUCCESS (0.514s)
[152.044185] [019/133] (869s left) kms_force_connector_basic (force-edid)
[152.121051] Starting subtest: force-edid
[152.489378] Subtest force-edid: SUCCESS (0.371s)
[152.645422] [020/133] (868s left) syncobj_wait (single-wait-submitted)
[152.714042] Starting subtest: single-wait-submitted
[152.817549] Subtest single-wait-submitted: SUCCESS (0.102s)
[152.913045] [021/133] (868s left) gem_mmap_gtt (cpuset-basic-small-copy)
[152.970835] Subtest cpuset-basic-small-copy: SKIP (0.000s)
[153.043048] [022/133] (868s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[153.147663] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[159.461319] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.315s)
[159.585420] [023/133] (862s left) kms_pm_lpsp (screens-disabled)
[160.689445] Starting subtest: screens-disabled
[160.693566] Subtest screens-disabled: SKIP (0.000s)
[160.772692] [024/133] (860s left) kms_plane (pixel-format-4-tiled-modifier)
[160.863437] Starting subtest: pixel-format-4-tiled-modifier
[160.889540] Starting dynamic subtest: pipe-A-plane-0
[161.489147] Dynamic subtest pipe-A-plane-0: SUCCESS (0.600s)
[161.497254] Starting dynamic subtest: pipe-A-plane-3
[161.878096] Dynamic subtest pipe-A-plane-3: SUCCESS (0.388s)
[161.885922] Starting dynamic subtest: pipe-A-plane-5
[161.889450] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[163.028162] Starting dynamic subtest: pipe-B-plane-0
[163.632820] Dynamic subtest pipe-B-plane-0: SUCCESS (0.611s)
[163.640562] Starting dynamic subtest: pipe-B-plane-3
[164.033225] Dynamic subtest pipe-B-plane-3: SUCCESS (0.399s)
[164.041967] Starting dynamic subtest: pipe-B-plane-5
[164.045372] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[164.346874] Subtest pixel-format-4-tiled-modifier: SUCCESS (3.483s)
[165.178847] [025/133] (856s left) kms_addfb_basic (bad-pitch-999)
[165.225472] Starting subtest: bad-pitch-999
[165.227467] Subtest bad-pitch-999: SUCCESS (0.000s)
[165.380913] [026/133] (856s left) perf_pmu (init-sema)
[165.421316] Starting subtest: init-sema
[165.423673] Starting dynamic subtest: rcs0
[165.425982] Dynamic subtest rcs0: SUCCESS (0.002s)
[165.437162] Starting dynamic subtest: bcs0
[165.439339] Dynamic subtest bcs0: SUCCESS (0.000s)
[165.447506] Starting dynamic subtest: vcs0
[165.449422] Dynamic subtest vcs0: SUCCESS (0.001s)
[165.456709] Starting dynamic subtest: vcs1
[165.458640] Dynamic subtest vcs1: SUCCESS (0.001s)
[165.466477] Starting dynamic subtest: vecs0
[165.468687] Dynamic subtest vecs0: SUCCESS (0.000s)
[165.477733] Starting dynamic subtest: ccs0
[165.479649] Dynamic subtest ccs0: SUCCESS (0.000s)
[165.481533] Subtest init-sema: SUCCESS (0.008s)
[165.568169] [027/133] (856s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[165.959633] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[166.744964] [028/133] (855s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[166.868803] Starting subtest: flip-vs-cursor-toggle
[175.315085] Subtest flip-vs-cursor-toggle: SUCCESS (8.446s)
[176.174183] [029/133] (845s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[176.239513] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[176.327405] [030/133] (845s left) kms_vblank (ts-continuation-idle-hang)
[176.418267] Starting subtest: ts-continuation-idle-hang
[176.420141] Starting dynamic subtest: pipe-A-eDP-1
[202.641933] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.219s)
[202.655521] Starting dynamic subtest: pipe-D-eDP-1
[227.658925] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.012s)
[227.661464] Subtest ts-continuation-idle-hang: SUCCESS (51.236s)
[228.478252] [031/133] (793s left) kms_cursor_crc (cursor-random-128x42)
[228.704244] Starting subtest: cursor-random-128x42
[228.744239] Subtest cursor-random-128x42: SKIP (0.038s)
[228.983191] [032/133] (792s left) kms_psr (psr-sprite-blt)
[229.064837] Starting subtest: psr-sprite-blt
[229.067539] Starting dynamic subtest: eDP-1
[230.767389] Dynamic subtest eDP-1: SUCCESS (1.702s)
[230.769654] Subtest psr-sprite-blt: SUCCESS (1.703s)
[231.600154] [033/133] (790s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[231.701605] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[231.706044] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[231.777837] [034/133] (790s left) gem_exec_reloc (basic-write-cpu-active)
[231.830542] Subtest basic-write-cpu-active: SKIP (0.000s)
[231.907712] [035/133] (790s left) syncobj_timeline (invalid-signal-illegal-point)
[231.975914] Starting subtest: invalid-signal-illegal-point
[231.977923] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[232.113832] [036/133] (789s left) gem_ctx_persistence (heartbeat-many)
[232.180363] Starting subtest: heartbeat-many
[232.185046] Subtest heartbeat-many: SKIP (0.000s)
[232.302993] [037/133] (789s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[232.394406] Starting subtest: primary-y-tiled-reflect-x-90
[232.398592] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s)
[232.477377] [038/133] (789s left) kms_flip (blocking-absolute-wf_vblank)
[232.578452] Starting subtest: blocking-absolute-wf_vblank
[232.580409] Starting dynamic subtest: A-eDP1
[241.333077] Dynamic subtest A-eDP1: SUCCESS (8.717s)
[241.343490] Starting dynamic subtest: B-eDP1
[250.028027] Dynamic subtest B-eDP1: SUCCESS (8.695s)
[250.037382] Starting dynamic subtest: C-eDP1
[258.733871] Dynamic subtest C-eDP1: SUCCESS (8.690s)
[258.743093] Starting dynamic subtest: D-eDP1
[267.422896] Dynamic subtest D-eDP1: SUCCESS (8.685s)
[267.425264] Subtest blocking-absolute-wf_vblank: SUCCESS (34.798s)
[268.578574] [039/133] (753s left) i915_pm_rpm (system-suspend)
[270.097879] Starting subtest: system-suspend
[287.874572] Subtest system-suspend: SUCCESS (2.960s)
[288.254435] [040/133] (734s left) kms_cursor_legacy (forked-bo)
[288.394628] Starting subtest: forked-bo
[288.396761] Starting dynamic subtest: pipe-A
[293.813986] Dynamic subtest pipe-A: SUCCESS (5.446s)
[293.823311] Starting dynamic subtest: pipe-B
[299.231655] Dynamic subtest pipe-B: SUCCESS (5.457s)
[299.240843] Starting dynamic subtest: pipe-C
[304.679400] Dynamic subtest pipe-C: SUCCESS (5.463s)
[304.688669] Starting dynamic subtest: pipe-D
[310.134779] Dynamic subtest pipe-D: SUCCESS (5.465s)
[310.146831] Starting dynamic subtest: all-pipes
[315.627695] Dynamic subtest all-pipes: SUCCESS (5.500s)
[315.629778] Subtest forked-bo: SUCCESS (27.342s)
[315.731790] [041/133] (706s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[315.850189] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[315.852483] Starting dynamic subtest: pipe-A
[315.870372] Dynamic subtest pipe-A: SKIP (0.015s)
[315.880676] Starting dynamic subtest: pipe-B
[315.899474] Dynamic subtest pipe-B: SKIP (0.029s)
[315.909706] Starting dynamic subtest: pipe-C
[315.928713] Dynamic subtest pipe-C: SKIP (0.029s)
[315.938798] Starting dynamic subtest: pipe-D
[315.957464] Dynamic subtest pipe-D: SKIP (0.029s)
[315.961329] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.105s)
[316.093783] [042/133] (706s left) gem_render_copy_redux (flink)
[316.151445] Starting subtest: flink
[316.874619] Subtest flink: SUCCESS (0.724s)
[317.032572] [043/133] (705s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[317.153670] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[317.157458] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[317.288532] [044/133] (705s left) prime_mmap (test_userptr)
[317.338110] Starting subtest: test_userptr
[317.340041] Starting dynamic subtest: test_userptr-smem
[317.341657] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[317.343246] Subtest test_userptr: SUCCESS (0.001s)
[317.450860] [045/133] (705s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[317.502869] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[317.604381] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.102s)
[317.699426] [046/133] (704s left) core_auth (many-magics)
[317.762039] Starting subtest: many-magics
[318.562836] Subtest many-magics: SUCCESS (0.802s)
[318.706807] [047/133] (703s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[318.776062] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[318.887374] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.109s)
[318.974548] [048/133] (703s left) kms_cursor_crc (cursor-sliding-max-size)
[319.268832] Starting subtest: cursor-sliding-max-size
[319.275431] Subtest cursor-sliding-max-size: SKIP (0.000s)
[319.436145] [049/133] (703s left) syncobj_wait (wait-all-for-submit-snapshot)
[319.492796] Starting subtest: wait-all-for-submit-snapshot
[319.572847] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[319.658740] [050/133] (703s left) kms_invalid_mode (zero-vdisplay)
[319.754956] Starting subtest: zero-vdisplay
[319.757202] Starting dynamic subtest: pipe-A-eDP-1
[320.036684] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.281s)
[320.046663] Starting dynamic subtest: pipe-B-eDP-1
[320.048679] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[320.057222] Starting dynamic subtest: pipe-C-eDP-1
[320.059358] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[320.067098] Starting dynamic subtest: pipe-D-eDP-1
[320.068944] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[320.070785] Subtest zero-vdisplay: SUCCESS (0.287s)
[320.850420] [051/133] (701s left) gem_userptr_blits (huge-split)
[320.930224] Starting subtest: huge-split
[320.936836] Subtest huge-split: SUCCESS (0.006s)
[321.066804] [052/133] (701s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[321.168084] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[321.172478] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[321.290312] [053/133] (701s left) gem_ctx_create (basic)
[321.342764] Starting subtest: basic
[321.345118] Subtest basic: SUCCESS (0.000s)
[321.535178] [054/133] (701s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[321.633653] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip
[322.657369] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.025s)
[322.815406] [055/133] (700s left) kms_lease (setcrtc-implicit-plane)
[322.904872] Starting subtest: setcrtc-implicit-plane
[322.906906] Starting dynamic subtest: pipe-A-eDP-1
[323.365749] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.460s)
[323.375809] Starting dynamic subtest: pipe-B-eDP-1
[324.544718] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.177s)
[324.553881] Starting dynamic subtest: pipe-C-eDP-1
[325.637068] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.089s)
[325.646656] Starting dynamic subtest: pipe-D-eDP-1
[326.733639] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.095s)
[326.735823] Subtest setcrtc-implicit-plane: SUCCESS (3.827s)
[327.540681] [056/133] (695s left) kms_psr (pr-sprite-mmap-cpu)
[327.650303] Starting subtest: pr-sprite-mmap-cpu
[327.654637] Subtest pr-sprite-mmap-cpu: SKIP (0.000s)
[327.731584] [057/133] (695s left) perf (gen12-unprivileged-single-ctx-counters)
[327.847454] Starting subtest: gen12-unprivileged-single-ctx-counters
[327.849203] Starting dynamic subtest: rcs0
[327.887194] Dynamic subtest rcs0: SUCCESS (0.041s)
[327.889515] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.043s)
[327.938655] [058/133] (695s left) gem_lmem_swapping (heavy-verify-random)
[327.976794] Subtest heavy-verify-random: SKIP (0.000s)
[328.014235] [059/133] (694s left) gem_busy (close-race)
[328.128799] Starting subtest: close-race
[351.745215] Subtest close-race: SUCCESS (23.616s)
[352.133317] [FACT gem_busy (close-race)] new: kernel.kmod_is_loaded.vgem: true
[352.138436] [060/133] (670s left) gem_exec_balancer (parallel-out-fence)
[352.451587] Starting subtest: parallel-out-fence
[353.514398] Subtest parallel-out-fence: SUCCESS (1.066s)
[353.663765] [061/133] (669s left) gem_ctx_shared (q-smoketest-all)
[353.742804] Starting subtest: Q-smoketest-all
[386.136114] Subtest Q-smoketest-all: SUCCESS (32.353s)
[387.855569] [062/133] (635s left) kms_psr (fbc-pr-primary-blt)
[387.957237] Starting subtest: fbc-pr-primary-blt
[387.961660] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[388.040252] [063/133] (635s left) api_intel_allocator (fork-simple-once)
[388.101445] Starting subtest: fork-simple-once
[388.113475] Subtest fork-simple-once: SUCCESS (0.014s)
[388.248283] [064/133] (634s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[388.333401] Starting subtest: flip-vs-dpms-on-nop-interruptible
[388.335709] Starting dynamic subtest: A-eDP1
[390.186059] Dynamic subtest A-eDP1: SUCCESS (1.850s)
[390.198910] Starting dynamic subtest: B-eDP1
[391.983049] Dynamic subtest B-eDP1: SUCCESS (1.794s)
[391.995041] Starting dynamic subtest: C-eDP1
[393.775385] Dynamic subtest C-eDP1: SUCCESS (1.791s)
[393.787046] Starting dynamic subtest: D-eDP1
[395.577010] Dynamic subtest D-eDP1: SUCCESS (1.800s)
[395.579463] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.244s)
[396.734279] [065/133] (626s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[396.849098] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[396.854175] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[396.970382] [066/133] (626s left) kms_selftest (drm_format)
[397.030059] Starting subtest: drm_format
[397.115454] Starting dynamic subtest: drm_test_format_block_width_invalid
[397.271310] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.155s)
[397.282168] Starting dynamic subtest: drm_test_format_block_width_one_plane
[397.412197] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.139s)
[397.422523] Starting dynamic subtest: drm_test_format_block_width_two_plane
[397.566330] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.152s)
[397.577019] Starting dynamic subtest: drm_test_format_block_width_three_plane
[397.716382] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.148s)
[397.726895] Starting dynamic subtest: drm_test_format_block_width_tiled
[397.862481] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.146s)
[397.871142] Starting dynamic subtest: drm_test_format_block_height_invalid
[398.010547] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.147s)
[398.019184] Starting dynamic subtest: drm_test_format_block_height_one_plane
[398.162255] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.150s)
[398.172805] Starting dynamic subtest: drm_test_format_block_height_two_plane
[398.301549] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.140s)
[398.310022] Starting dynamic subtest: drm_test_format_block_height_three_plane
[398.448957] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.147s)
[398.457576] Starting dynamic subtest: drm_test_format_block_height_tiled
[398.585225] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.134s)
[398.595674] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[398.720939] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.135s)
[398.729886] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[398.855567] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.134s)
[398.864358] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[398.994349] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.137s)
[399.005226] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[399.130006] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.135s)
[399.138982] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[399.271033] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.140s)
[399.281821] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[399.376641] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.106s)
[399.385564] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[399.487597] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.109s)
[399.498295] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[399.600660] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.113s)
[399.602833] Subtest drm_format: SUCCESS (2.572s)
[399.791519] [067/133] (623s left) gem_exec_schedule (deep)
[399.986398] Starting subtest: deep
[399.988598] Starting dynamic subtest: rcs0
[406.026272] Dynamic subtest rcs0: SKIP (6.036s)
[406.045946] Starting dynamic subtest: vcs0
[415.922258] Dynamic subtest vcs0: SUCCESS (9.898s)
[415.933643] Starting dynamic subtest: vcs1
[426.519820] Dynamic subtest vcs1: SUCCESS (10.595s)
[426.532937] Starting dynamic subtest: vecs0
[437.099022] Dynamic subtest vecs0: SUCCESS (10.580s)
[437.110860] Starting dynamic subtest: ccs0
[449.167265] Dynamic subtest ccs0: SUCCESS (12.069s)
[449.169636] Subtest deep: SUCCESS (49.183s)
[450.375876] [068/133] (573s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[450.480028] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[450.482315] Starting dynamic subtest: pipe-A
[451.657487] Dynamic subtest pipe-A: SUCCESS (1.180s)
[451.673061] Starting dynamic subtest: pipe-B
[453.951442] Dynamic subtest pipe-B: SUCCESS (2.293s)
[453.960336] Starting dynamic subtest: pipe-C
[455.157456] Dynamic subtest pipe-C: SUCCESS (1.205s)
[455.169042] Starting dynamic subtest: pipe-D
[456.353401] Dynamic subtest pipe-D: SUCCESS (1.195s)
[456.355564] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.877s)
[457.528967] [069/133] (565s left) gem_exec_flush (basic-batch-kernel-default-wb)
[457.594561] Starting subtest: basic-batch-kernel-default-wb
[464.700397] Subtest basic-batch-kernel-default-wb: SUCCESS (7.108s)
[464.907769] [070/133] (558s left) gem_mmap_wc (bad-object)
[464.967783] Subtest bad-object: SKIP (0.000s)
[465.028533] [071/133] (558s left) gem_basic (create-close)
[465.085197] Starting subtest: create-close
[465.089594] Subtest create-close: SUCCESS (0.000s)
[465.211349] [072/133] (558s left) gem_mmap_offset (partial-unmap)
[465.278054] Starting subtest: partial-unmap
[465.279978] Starting dynamic subtest: smem0
[465.750713] Dynamic subtest smem0: SUCCESS (0.473s)
[465.753722] Subtest partial-unmap: SUCCESS (0.474s)
[465.910294] [073/133] (557s left) gem_bad_reloc (negative-reloc-lut)
[465.979904] Subtest negative-reloc-lut: SKIP (0.000s)
[466.063869] [074/133] (557s left) gem_tiled_partial_pwrite_pread (writes)
[466.131980] Subtest writes: SKIP (0.000s)
[466.201934] [075/133] (557s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[466.304714] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[472.884694] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (6.584s)
[473.044637] [076/133] (550s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[473.145606] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[473.149603] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[473.258740] [077/133] (550s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[473.357251] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[473.359466] Starting dynamic subtest: pipe-A-eDP-1
[473.509567] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.143s)
[473.521199] Starting dynamic subtest: pipe-B-eDP-1
[473.540484] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[473.550318] Starting dynamic subtest: pipe-C-eDP-1
[473.570387] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[473.579867] Starting dynamic subtest: pipe-D-eDP-1
[473.599383] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s)
[473.601544] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.179s)
[475.928549] [078/133] (547s left) kms_pm_rpm (modeset-stress-extra-wait)
[477.961703] Starting subtest: modeset-stress-extra-wait
[532.247960] Subtest modeset-stress-extra-wait: SUCCESS (54.238s)
[532.299298] [079/133] (491s left) kms_atomic (plane-immutable-zpos)
[532.400523] Starting subtest: plane-immutable-zpos
[532.402913] Starting dynamic subtest: pipe-A-eDP-1
[533.022614] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.618s)
[533.024811] Subtest plane-immutable-zpos: SUCCESS (0.620s)
[533.917837] [080/133] (489s left) syncobj_timeline (reset-unsignaled)
[533.982098] Starting subtest: reset-unsignaled
[533.984346] Subtest reset-unsignaled: SUCCESS (0.000s)
[534.087255] [081/133] (489s left) kms_color (gamma)
[534.183441] Starting subtest: gamma
[534.185706] Starting dynamic subtest: pipe-A-eDP-1
[534.903453] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.719s)
[534.914553] Starting dynamic subtest: pipe-B-eDP-1
[536.289019] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.381s)
[536.300789] Starting dynamic subtest: pipe-C-eDP-1
[537.584355] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.296s)
[537.594666] Starting dynamic subtest: pipe-D-eDP-1
[538.898601] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.312s)
[538.900804] Subtest gamma: SUCCESS (4.711s)
[539.725311] [082/133] (484s left) gem_pipe_control_store_loop (reused-buffer)
[539.791450] Starting subtest: reused-buffer
[541.997031] Subtest reused-buffer: SUCCESS (2.153s)
[542.074099] [083/133] (481s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[542.676382] Starting subtest: syncobj-backward-timeline-chain-engines
[542.826202] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.153s)
[543.874923] [084/133] (480s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[543.986645] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[543.990936] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[544.126375] [085/133] (479s left) kms_cursor_crc (cursor-dpms)
[544.256041] Starting subtest: cursor-dpms
[544.258305] Starting dynamic subtest: pipe-A-eDP-1
[547.192377] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.936s)
[547.202939] Starting dynamic subtest: pipe-D-eDP-1
[550.776738] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.583s)
[550.779117] Subtest cursor-dpms: SUCCESS (6.521s)
[551.610123] [086/133] (472s left) gen9_exec_parse (bb-oversize)
[551.676697] Subtest bb-oversize: SKIP (0.000s)
[551.761644] [087/133] (472s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[551.849192] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[551.851397] Starting dynamic subtest: pipe-A-eDP-1
[551.873972] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[551.885538] Starting dynamic subtest: pipe-B-eDP-1
[551.906828] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[551.915961] Starting dynamic subtest: pipe-C-eDP-1
[551.937300] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[551.946203] Starting dynamic subtest: pipe-D-eDP-1
[551.968443] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[551.972422] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[554.110720] [088/133] (470s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[554.215113] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[554.217264] Starting dynamic subtest: pipe-A-eDP-1
[554.274958] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.061s)
[554.571438] Starting dynamic subtest: pipe-B-eDP-1
[555.370238] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.810s)
[555.655606] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.442s)
[556.521576] [089/133] (467s left) gem_exec_whisper (basic-queues)
[556.590572] Starting subtest: basic-queues
[561.741607] Subtest basic-queues: SUCCESS (5.151s)
[561.941318] [090/133] (462s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[562.046990] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[562.179654] [091/133] (462s left) gem_eio (wait-immediate)
[562.440907] Starting subtest: wait-immediate
[562.846498] Subtest wait-immediate: SUCCESS (0.406s)
[563.020167] [092/133] (461s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[563.404891] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[564.187894] [093/133] (460s left) gem_spin_batch (spin-all-new)
[564.258511] Starting subtest: spin-all-new
[564.274378] Subtest spin-all-new: SUCCESS (0.014s)
[565.750110] [094/133] (458s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[565.851574] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[574.998087] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.148s)
[575.150722] [095/133] (449s left) kms_flip (dpms-off-confusion)
[575.253737] Starting subtest: dpms-off-confusion
[575.256054] Starting dynamic subtest: A-eDP1
[583.963741] Dynamic subtest A-eDP1: SUCCESS (8.709s)
[583.974341] Starting dynamic subtest: B-eDP1
[592.698470] Dynamic subtest B-eDP1: SUCCESS (8.699s)
[592.710990] Starting dynamic subtest: C-eDP1
[601.419672] Dynamic subtest C-eDP1: SUCCESS (8.707s)
[601.431285] Starting dynamic subtest: D-eDP1
[610.111621] Dynamic subtest D-eDP1: SUCCESS (8.687s)
[610.114021] Subtest dpms-off-confusion: SUCCESS (34.817s)
[611.312716] [096/133] (413s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[611.412916] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[611.417426] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[611.543085] [097/133] (413s left) gem_exec_schedule (noreorder-priority)
[611.733587] Starting subtest: noreorder-priority
[611.736028] Starting dynamic subtest: rcs0
[612.882109] Dynamic subtest rcs0: SUCCESS (1.148s)
[612.898751] Starting dynamic subtest: vcs0
[614.729011] Dynamic subtest vcs0: SUCCESS (1.843s)
[614.746764] Starting dynamic subtest: vcs1
[616.712691] Dynamic subtest vcs1: SUCCESS (1.981s)
[616.729797] Starting dynamic subtest: vecs0
[618.736113] Dynamic subtest vecs0: SUCCESS (2.021s)
[618.749399] Starting dynamic subtest: ccs0
[619.918446] Dynamic subtest ccs0: SUCCESS (1.181s)
[619.921353] Subtest noreorder-priority: SUCCESS (8.187s)
[620.129304] [098/133] (404s left) vgem_basic (bad-flag)
[620.180097] Starting subtest: bad-flag
[620.182456] Subtest bad-flag: SUCCESS (0.000s)
[620.246453] [099/133] (404s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[620.307053] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[620.309581] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[620.428521] [100/133] (404s left) kms_psr (fbc-psr-primary-mmap-gtt)
[620.527225] Starting subtest: fbc-psr-primary-mmap-gtt
[620.529439] Starting dynamic subtest: eDP-1
[620.533574] Dynamic subtest eDP-1: SKIP (0.000s)
[620.537699] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s)
[620.611829] [101/133] (404s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[620.711310] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[620.715305] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[620.832015] [102/133] (403s left) gem_ringfill (basic-all)
[626.756979] Starting subtest: basic-all
[627.926541] Subtest basic-all: SUCCESS (1.169s)
[628.070013] [103/133] (396s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[628.183360] Starting subtest: x-tiled-32bpp-rotate-270
[628.201468] Subtest x-tiled-32bpp-rotate-270: SKIP (0.017s)
[628.350367] [104/133] (396s left) prime_busy (before-wait)
[628.414962] Starting subtest: before-wait
[628.420625] Starting dynamic subtest: rcs0
[628.463407] Dynamic subtest rcs0: SUCCESS (0.046s)
[628.475503] Starting dynamic subtest: bcs0
[628.526819] Dynamic subtest bcs0: SUCCESS (0.062s)
[628.537886] Starting dynamic subtest: vcs0
[628.567374] Dynamic subtest vcs0: SUCCESS (0.040s)
[628.576671] Starting dynamic subtest: vcs1
[628.607942] Dynamic subtest vcs1: SUCCESS (0.040s)
[628.617737] Starting dynamic subtest: vecs0
[628.647379] Dynamic subtest vecs0: SUCCESS (0.039s)
[628.657290] Starting dynamic subtest: ccs0
[628.687913] Dynamic subtest ccs0: SUCCESS (0.040s)
[628.795533] Subtest before-wait: SUCCESS (0.379s)
[628.887046] [105/133] (396s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[629.020107] Starting subtest: cursorB-vs-flipB-varying-size
[629.024458] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[629.176314] [106/133] (395s left) drm_mm (drm_mm)
[629.218577] Starting subtest: drm_mm
[629.224919] Starting dynamic subtest: drm_test_mm_init
[629.363052] Dynamic subtest drm_test_mm_init: SUCCESS (0.136s)
[629.372596] Starting dynamic subtest: drm_test_mm_debug
[629.515355] Dynamic subtest drm_test_mm_debug: SUCCESS (0.152s)
[629.524882] Starting dynamic subtest: drm_test_mm_align32
[629.622228] Dynamic subtest drm_test_mm_align32: SUCCESS (0.105s)
[629.631271] Starting dynamic subtest: drm_test_mm_align64
[629.758019] Dynamic subtest drm_test_mm_align64: SUCCESS (0.135s)
[629.768818] Starting dynamic subtest: drm_test_mm_lowest
[629.904192] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.144s)
[629.914955] Starting dynamic subtest: drm_test_mm_highest
[630.036378] Dynamic subtest drm_test_mm_highest: SUCCESS (0.131s)
[630.038289] Subtest drm_mm: SUCCESS (0.816s)
[630.247416] [107/133] (394s left) i915_query (engine-info-invalid)
[630.300429] Starting subtest: engine-info-invalid
[630.302781] Subtest engine-info-invalid: SUCCESS (0.000s)
[630.428519] [108/133] (394s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[630.530013] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[636.965834] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.440s)
[637.132559] [109/133] (387s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[637.283455] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[638.245892] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.960s)
[639.102649] [110/133] (386s left) kms_feature_discovery (display-2x)
[639.202217] Starting subtest: display-2x
[639.206358] Subtest display-2x: SKIP (0.000s)
[639.289272] [111/133] (385s left) gem_ctx_isolation (dirty-create)
[639.352580] Starting subtest: dirty-create
[639.354875] Starting dynamic subtest: rcs0
[639.542871] Dynamic subtest rcs0: SUCCESS (0.190s)
[639.553980] Starting dynamic subtest: bcs0
[639.755050] Dynamic subtest bcs0: SUCCESS (0.211s)
[639.767454] Starting dynamic subtest: vcs0
[639.968130] Dynamic subtest vcs0: SUCCESS (0.212s)
[639.980394] Starting dynamic subtest: vcs1
[641.957257] Dynamic subtest vcs1: SUCCESS (1.988s)
[641.968907] Starting dynamic subtest: vecs0
[643.932899] Dynamic subtest vecs0: SUCCESS (1.975s)
[643.945241] Starting dynamic subtest: ccs0
[645.997353] Dynamic subtest ccs0: SUCCESS (2.064s)
[645.999681] Subtest dirty-create: SUCCESS (6.646s)
[646.262146] [112/133] (378s left) gem_tiled_wb
[646.392877] [113/133] (378s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[646.487082] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[646.491444] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[646.586021] [114/133] (378s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[646.677060] Starting subtest: crc-primary-suspend-y-tiled-ccs
[646.679250] Starting dynamic subtest: pipe-A-eDP-1
[646.687784] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[646.697686] Starting dynamic subtest: pipe-B-eDP-1
[646.706396] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[646.718391] Starting dynamic subtest: pipe-C-eDP-1
[646.726878] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[646.735917] Starting dynamic subtest: pipe-D-eDP-1
[646.744334] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[646.748447] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.005s)
[648.911552] [115/133] (376s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[649.013417] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[649.017638] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[649.150963] [116/133] (376s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[649.255792] Starting subtest: pr-overlay-plane-move-continuous-sf
[649.259917] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[649.341251] [117/133] (376s left) gem_exec_flush (basic-wb-rw-default)
[649.401900] Starting subtest: basic-wb-rw-default
[654.887032] Subtest basic-wb-rw-default: SUCCESS (5.458s)
[655.063560] [118/133] (370s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[655.177604] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[655.182037] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[655.322617] [119/133] (370s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[655.452591] Starting subtest: cursor-vs-flip-atomic-transitions
[685.198684] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (29.748s)
[686.098736] [120/133] (339s left) gem_softpin (invalid)
[686.174213] Starting subtest: invalid
[686.182081] Subtest invalid: SUCCESS (0.006s)
[686.337495] [121/133] (339s left) kms_pipe_stress (stress-xrgb8888-4tiled)
[686.426530] Starting subtest: stress-xrgb8888-4tiled
[692.350073] Subtest stress-xrgb8888-4tiled: SUCCESS (5.925s)
[692.404947] [122/133] (333s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[692.527609] Starting subtest: 2x-long-flip-vs-cursor-atomic
[692.531447] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s)
[692.697386] [123/133] (332s left) sw_sync (sync_merge_same)
[692.739246] Starting subtest: sync_merge_same
[692.740828] Subtest sync_merge_same: SUCCESS (0.000s)
[692.809029] [124/133] (332s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[692.915941] Starting subtest: y-tiled-16bpp-rotate-90
[692.919593] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[693.049550] [125/133] (332s left) kms_chamelium_color (ctm-negative)
[693.149804] Subtest ctm-negative: SKIP (0.000s)
[693.192957] [126/133] (332s left) gem_exec_flush (basic-wb-prw-default)
[693.268117] Starting subtest: basic-wb-prw-default
[698.757636] Subtest basic-wb-prw-default: SUCCESS (5.479s)
[698.943220] [127/133] (326s left) kms_psr (fbc-psr2-primary-page-flip)
[699.034192] Starting subtest: fbc-psr2-primary-page-flip
[699.036506] Starting dynamic subtest: eDP-1
[699.040902] Dynamic subtest eDP-1: SKIP (0.000s)
[699.045339] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[699.119297] [128/133] (326s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[699.210337] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[705.905212] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.700s)
[706.042330] [129/133] (319s left) gem_exec_schedule (u-semaphore-codependency)
[706.117897] Starting subtest: u-semaphore-codependency
[706.123841] Subtest u-semaphore-codependency: SUCCESS (0.013s)
[706.502583] [130/133] (319s left) gem_create (create-invalid-size)
[706.557044] Starting subtest: create-invalid-size
[706.559280] Subtest create-invalid-size: SUCCESS (0.000s)
[706.757327] [131/133] (319s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[706.856440] Starting subtest: yf-tiled-16bpp-rotate-90
[706.861195] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[706.969008] [132/133] (319s left) kms_psr (psr2-primary-render)
[707.073626] Starting subtest: psr2-primary-render
[707.075855] Starting dynamic subtest: eDP-1
[708.840586] Dynamic subtest eDP-1: SUCCESS (1.764s)
[708.842915] Subtest psr2-primary-render: SUCCESS (1.766s)
[709.682479] [133/133] (316s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[709.794598] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[709.798988] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[709.916639] Closing watchdogs
results: parsing output: 0/ for test: gem_pxp
results: parsing output: 1/ for test: kms_async_flips
results: parsing output: 2/ for test: i915_drm_fdinfo
results: parsing output: 3/ for test: kms_content_protection
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: syncobj_basic
results: parsing output: 6/ for test: sw_sync
results: parsing output: 7/ for test: api_intel_bb
results: parsing output: 8/ for test: kms_flip
results: parsing output: 9/ for test: gem_exec_balancer
results: parsing output: 10/ for test: i915_drm_fdinfo
results: parsing output: 11/ for test: gem_ctx_bad_destroy
results: parsing output: 12/ for test: kms_plane_cursor
results: parsing output: 13/ for test: gem_exec_params
results: parsing output: 14/ for test: kms_ccs
results: parsing output: 15/ for test: syncobj_timeline
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: gem_ctx_engines
results: parsing output: 18/ for test: kms_force_connector_basic
results: parsing output: 19/ for test: syncobj_wait
results: parsing output: 20/ for test: gem_mmap_gtt
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_pm_lpsp
results: parsing output: 23/ for test: kms_plane
results: parsing output: 24/ for test: kms_addfb_basic
results: parsing output: 25/ for test: perf_pmu
results: parsing output: 26/ for test: kms_chamelium_hpd
results: parsing output: 27/ for test: kms_cursor_legacy
results: parsing output: 28/ for test: gem_fenced_exec_thrash
results: parsing output: 29/ for test: kms_vblank
results: parsing output: 30/ for test: kms_cursor_crc
results: parsing output: 31/ for test: kms_psr
results: parsing output: 32/ for test: kms_psr2_sf
results: parsing output: 33/ for test: gem_exec_reloc
results: parsing output: 34/ for test: syncobj_timeline
results: parsing output: 35/ for test: gem_ctx_persistence
results: parsing output: 36/ for test: kms_rotation_crc
results: parsing output: 37/ for test: kms_flip
results: parsing output: 38/ for test: i915_pm_rpm
results: parsing output: 39/ for test: kms_cursor_legacy
results: parsing output: 40/ for test: kms_plane_scaling
results: parsing output: 41/ for test: gem_render_copy_redux
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: prime_mmap
results: parsing output: 44/ for test: syncobj_wait
results: parsing output: 45/ for test: core_auth
results: parsing output: 46/ for test: syncobj_timeline
results: parsing output: 47/ for test: kms_cursor_crc
results: parsing output: 48/ for test: syncobj_wait
results: parsing output: 49/ for test: kms_invalid_mode
results: parsing output: 50/ for test: gem_userptr_blits
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: gem_ctx_create
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: kms_lease
results: parsing output: 55/ for test: kms_psr
results: parsing output: 56/ for test: perf
results: parsing output: 57/ for test: gem_lmem_swapping
results: parsing output: 58/ for test: gem_busy
results: parsing output: 59/ for test: gem_exec_balancer
results: parsing output: 60/ for test: gem_ctx_shared
results: parsing output: 61/ for test: kms_psr
results: parsing output: 62/ for test: api_intel_allocator
results: parsing output: 63/ for test: kms_flip
results: parsing output: 64/ for test: kms_big_fb
results: parsing output: 65/ for test: kms_selftest
results: parsing output: 66/ for test: gem_exec_schedule
results: parsing output: 67/ for test: kms_plane_scaling
results: parsing output: 68/ for test: gem_exec_flush
results: parsing output: 69/ for test: gem_mmap_wc
results: parsing output: 70/ for test: gem_basic
results: parsing output: 71/ for test: gem_mmap_offset
results: parsing output: 72/ for test: gem_bad_reloc
results: parsing output: 73/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_ccs
results: parsing output: 77/ for test: kms_pm_rpm
results: parsing output: 78/ for test: kms_atomic
results: parsing output: 79/ for test: syncobj_timeline
results: parsing output: 80/ for test: kms_color
results: parsing output: 81/ for test: gem_pipe_control_store_loop
results: parsing output: 82/ for test: gem_exec_fence
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_cursor_crc
results: parsing output: 85/ for test: gen9_exec_parse
results: parsing output: 86/ for test: kms_ccs
results: parsing output: 87/ for test: kms_atomic_transition
results: parsing output: 88/ for test: gem_exec_whisper
results: parsing output: 89/ for test: kms_addfb_basic
results: parsing output: 90/ for test: gem_eio
results: parsing output: 91/ for test: kms_chamelium_frames
results: parsing output: 92/ for test: gem_spin_batch
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_flip
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: gem_exec_schedule
results: parsing output: 97/ for test: vgem_basic
results: parsing output: 98/ for test: syncobj_timeline
results: parsing output: 99/ for test: kms_psr
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: gem_ringfill
results: parsing output: 102/ for test: kms_big_fb
results: parsing output: 103/ for test: prime_busy
results: parsing output: 104/ for test: kms_cursor_legacy
results: parsing output: 105/ for test: drm_mm
results: parsing output: 106/ for test: i915_query
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_cursor_legacy
results: parsing output: 109/ for test: kms_feature_discovery
results: parsing output: 110/ for test: gem_ctx_isolation
results: parsing output: 111/ for test: gem_tiled_wb
results: parsing output: 112/ for test: kms_flip_scaled_crc
results: parsing output: 113/ for test: kms_ccs
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_psr2_sf
results: parsing output: 116/ for test: gem_exec_flush
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_cursor_legacy
results: parsing output: 119/ for test: gem_softpin
results: parsing output: 120/ for test: kms_pipe_stress
results: parsing output: 121/ for test: kms_cursor_legacy
results: parsing output: 122/ for test: sw_sync
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: kms_chamelium_color
results: parsing output: 125/ for test: gem_exec_flush
results: parsing output: 126/ for test: kms_psr
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: gem_exec_schedule
results: parsing output: 129/ for test: gem_create
results: parsing output: 130/ for test: kms_big_fb
results: parsing output: 131/ for test: kms_psr
results: parsing output: 132/ for test: kms_big_fb
Done.