[58.254477] Initializing watchdogs
[58.254525]   /dev/watchdog0
[58.268540] [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]
[58.273073] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.275488] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.278935] [001/133] (960s left) gem_pxp (reject-modify-context-protection-on)
[58.435196] Starting subtest: reject-modify-context-protection-on
[58.437643] Subtest reject-modify-context-protection-on: SUCCESS (0.002s)
[58.548727] [002/133] (960s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[58.664957] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[59.802083] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[62.220045] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.420s)
[62.230176] Starting dynamic subtest: pipe-A-eDP-1-4
[64.401614] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.184s)
[64.408916] Starting dynamic subtest: pipe-A-eDP-1-4
[66.409436] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[66.416839] Starting dynamic subtest: pipe-A-eDP-1-x
[68.586388] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.178s)
[68.949402] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[71.738104] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.795s)
[71.745543] Starting dynamic subtest: pipe-B-eDP-1-4
[73.923491] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.185s)
[73.933430] Starting dynamic subtest: pipe-B-eDP-1-4
[75.932464] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[75.939848] Starting dynamic subtest: pipe-B-eDP-1-x
[78.122088] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.190s)
[78.484168] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[81.271129] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.792s)
[81.279811] Starting dynamic subtest: pipe-C-eDP-1-4
[83.457445] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.185s)
[83.467802] Starting dynamic subtest: pipe-C-eDP-1-4
[85.467860] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.010s)
[85.475296] Starting dynamic subtest: pipe-C-eDP-1-x
[87.646666] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s)
[88.007344] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[90.797634] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.796s)
[90.807945] Starting dynamic subtest: pipe-D-eDP-1-4
[92.973196] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.175s)
[92.985789] Starting dynamic subtest: pipe-D-eDP-1-4
[94.983377] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[94.993897] Starting dynamic subtest: pipe-D-eDP-1-x
[97.161285] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s)
[97.163791] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.511s)
[98.388691] [003/133] (920s left) i915_drm_fdinfo (basics)
[98.434925] Starting subtest: basics
[98.437283] Subtest basics: SUCCESS (0.000s)
[98.508457] [004/133] (920s left) kms_content_protection (dp-mst-lic-type-0)
[98.655550] Starting subtest: dp-mst-lic-type-0
[98.659791] Subtest dp-mst-lic-type-0: SKIP (0.000s)
[98.806634] [005/133] (920s left) kms_big_fb (linear-16bpp-rotate-0)
[98.905253] Starting subtest: linear-16bpp-rotate-0
[100.350376] Subtest linear-16bpp-rotate-0: SUCCESS (1.446s)
[100.493834] [006/133] (918s left) syncobj_basic (test-valid-cycle)
[100.562145] Starting subtest: test-valid-cycle
[100.564223] Subtest test-valid-cycle: SUCCESS (0.000s)
[100.659854] [007/133] (918s left) sw_sync (timeline_closed_signaled)
[100.693221] Starting subtest: timeline_closed_signaled
[100.694921] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[100.788120] [008/133] (918s left) api_intel_bb (misplaced-blitter)
[100.853995] Starting subtest: misplaced-blitter
[100.861689] Subtest misplaced-blitter: SUCCESS (0.009s)
[101.009371] [009/133] (918s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[101.110252] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[101.121851] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s)
[101.240874] [010/133] (917s left) gem_exec_balancer (full-late-pulse)
[101.310906] Starting subtest: full-late-pulse
[105.830059] Subtest full-late-pulse: SUCCESS (4.519s)
[106.171789] [011/133] (913s left) i915_drm_fdinfo (virtual-busy-idle)
[106.216040] Starting subtest: virtual-busy-idle
[106.220548] Subtest virtual-busy-idle: SKIP (0.000s)
[106.295544] [012/133] (912s left) gem_ctx_bad_destroy (double-destroy)
[106.353363] Starting subtest: double-destroy
[106.355782] Subtest double-destroy: SUCCESS (0.000s)
[106.450259] [013/133] (912s left) kms_plane_cursor (primary)
[106.557640] Starting subtest: primary
[106.561745] Starting dynamic subtest: pipe-A-eDP-1-size-64
[109.096455] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.539s)
[109.121514] Starting dynamic subtest: pipe-A-eDP-1-size-128
[111.697450] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.583s)
[111.722074] Starting dynamic subtest: pipe-A-eDP-1-size-256
[114.309233] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.594s)
[114.625712] Starting dynamic subtest: pipe-B-eDP-1-size-64
[117.873789] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.256s)
[117.897019] Starting dynamic subtest: pipe-B-eDP-1-size-128
[120.429335] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.539s)
[120.452941] Starting dynamic subtest: pipe-B-eDP-1-size-256
[122.997991] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.549s)
[123.312157] Starting dynamic subtest: pipe-C-eDP-1-size-64
[126.206527] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.904s)
[126.232293] Starting dynamic subtest: pipe-C-eDP-1-size-128
[128.395523] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.169s)
[128.420441] Starting dynamic subtest: pipe-C-eDP-1-size-256
[130.573375] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.158s)
[130.892439] Starting dynamic subtest: pipe-D-eDP-1-size-64
[133.754371] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.871s)
[133.779938] Starting dynamic subtest: pipe-D-eDP-1-size-128
[136.021884] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.249s)
[136.045969] Starting dynamic subtest: pipe-D-eDP-1-size-256
[138.209213] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.169s)
[138.522158] Subtest primary: SUCCESS (31.963s)
[139.339223] [014/133] (879s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[139.405510] Starting subtest: rel-constants-invalid-rel-gen5
[139.407727] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[139.542953] [015/133] (879s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[139.650090] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[139.654297] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[140.751987] [016/133] (878s left) syncobj_timeline (single-wait-available-submitted)
[140.804510] Starting subtest: single-wait-available-submitted
[140.806483] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[140.940454] [017/133] (878s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[141.046410] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[148.364076] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.321s)
[148.521717] [018/133] (870s left) gem_ctx_engines (execute-oneforall)
[148.588032] Starting subtest: execute-oneforall
[149.113726] Subtest execute-oneforall: SUCCESS (0.525s)
[150.065233] [019/133] (869s left) kms_force_connector_basic (force-edid)
[150.150708] Starting subtest: force-edid
[150.512491] Subtest force-edid: SUCCESS (0.364s)
[150.661602] [020/133] (868s left) syncobj_wait (single-wait-submitted)
[150.723420] Starting subtest: single-wait-submitted
[150.826955] Subtest single-wait-submitted: SUCCESS (0.103s)
[150.938456] [021/133] (868s left) gem_mmap_gtt (cpuset-basic-small-copy)
[151.010120] Subtest cpuset-basic-small-copy: SKIP (0.000s)
[151.077896] [022/133] (868s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[151.179774] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[157.605657] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.428s)
[157.722280] [023/133] (861s left) kms_pm_lpsp (screens-disabled)
[158.829877] Starting subtest: screens-disabled
[158.834148] Subtest screens-disabled: SKIP (0.000s)
[158.926547] [024/133] (860s left) kms_plane (pixel-format-4-tiled-modifier)
[159.024508] Starting subtest: pixel-format-4-tiled-modifier
[159.053118] Starting dynamic subtest: pipe-A-plane-0
[159.695905] Dynamic subtest pipe-A-plane-0: SUCCESS (0.643s)
[159.704642] Starting dynamic subtest: pipe-A-plane-3
[160.151051] Dynamic subtest pipe-A-plane-3: SUCCESS (0.455s)
[160.159432] Starting dynamic subtest: pipe-A-plane-5
[160.163018] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[161.253104] Starting dynamic subtest: pipe-B-plane-0
[161.957766] Dynamic subtest pipe-B-plane-0: SUCCESS (0.711s)
[161.971306] Starting dynamic subtest: pipe-B-plane-3
[162.367978] Dynamic subtest pipe-B-plane-3: SUCCESS (0.410s)
[162.375874] Starting dynamic subtest: pipe-B-plane-5
[162.379466] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[162.682847] Subtest pixel-format-4-tiled-modifier: SUCCESS (3.657s)
[163.508926] [025/133] (856s left) kms_addfb_basic (bad-pitch-999)
[163.582484] Starting subtest: bad-pitch-999
[163.584378] Subtest bad-pitch-999: SUCCESS (0.000s)
[163.756804] [026/133] (856s left) perf_pmu (init-sema)
[163.802940] Starting subtest: init-sema
[163.805119] Starting dynamic subtest: rcs0
[163.807341] Dynamic subtest rcs0: SUCCESS (0.002s)
[163.819682] Starting dynamic subtest: bcs0
[163.821510] Dynamic subtest bcs0: SUCCESS (0.000s)
[163.828626] Starting dynamic subtest: vcs0
[163.830595] Dynamic subtest vcs0: SUCCESS (0.001s)
[163.841068] Starting dynamic subtest: vcs1
[163.843057] Dynamic subtest vcs1: SUCCESS (0.001s)
[163.850745] Starting dynamic subtest: vecs0
[163.852815] Dynamic subtest vecs0: SUCCESS (0.001s)
[163.860466] Starting dynamic subtest: ccs0
[163.862298] Dynamic subtest ccs0: SUCCESS (0.000s)
[163.864181] Subtest init-sema: SUCCESS (0.008s)
[163.911301] [027/133] (855s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[164.298127] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[165.072521] [028/133] (854s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[165.199478] Starting subtest: flip-vs-cursor-toggle
[173.872068] Subtest flip-vs-cursor-toggle: SUCCESS (8.670s)
[174.699876] [029/133] (845s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[174.758105] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[174.846517] [030/133] (845s left) kms_vblank (ts-continuation-idle-hang)
[174.940181] Starting subtest: ts-continuation-idle-hang
[174.942392] Starting dynamic subtest: pipe-A-eDP-1
[201.684616] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.743s)
[201.698458] Starting dynamic subtest: pipe-D-eDP-1
[226.650140] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.962s)
[226.652535] Subtest ts-continuation-idle-hang: SUCCESS (51.710s)
[227.491472] [031/133] (792s left) kms_cursor_crc (cursor-random-128x42)
[227.717651] Starting subtest: cursor-random-128x42
[227.764908] Subtest cursor-random-128x42: SKIP (0.041s)
[227.982676] [032/133] (792s left) kms_psr (psr-sprite-blt)
[228.072732] Starting subtest: psr-sprite-blt
[228.074906] Starting dynamic subtest: eDP-1
[229.801441] Dynamic subtest eDP-1: SUCCESS (1.728s)
[229.803774] Subtest psr-sprite-blt: SUCCESS (1.729s)
[230.596458] [033/133] (789s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[230.721730] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[230.725907] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[230.812526] [034/133] (789s left) gem_exec_reloc (basic-write-cpu-active)
[230.878574] Subtest basic-write-cpu-active: SKIP (0.000s)
[230.965639] [035/133] (789s left) syncobj_timeline (invalid-signal-illegal-point)
[231.022732] Starting subtest: invalid-signal-illegal-point
[231.025081] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[231.146987] [036/133] (789s left) gem_ctx_persistence (heartbeat-many)
[231.206581] Starting subtest: heartbeat-many
[231.211229] Subtest heartbeat-many: SKIP (0.000s)
[231.330302] [037/133] (788s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[231.430163] Starting subtest: primary-y-tiled-reflect-x-90
[231.434793] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s)
[231.531506] [038/133] (788s left) kms_flip (blocking-absolute-wf_vblank)
[231.629041] Starting subtest: blocking-absolute-wf_vblank
[231.630983] Starting dynamic subtest: A-eDP1
[240.311952] Dynamic subtest A-eDP1: SUCCESS (8.684s)
[240.327105] Starting dynamic subtest: B-eDP1
[249.020724] Dynamic subtest B-eDP1: SUCCESS (8.705s)
[249.037526] Starting dynamic subtest: C-eDP1
[257.696890] Dynamic subtest C-eDP1: SUCCESS (8.674s)
[257.705448] Starting dynamic subtest: D-eDP1
[266.403447] Dynamic subtest D-eDP1: SUCCESS (8.704s)
[266.405840] Subtest blocking-absolute-wf_vblank: SUCCESS (34.779s)
[267.618380] [039/133] (752s left) i915_pm_rpm (system-suspend)
[269.151656] Starting subtest: system-suspend
[286.971112] Subtest system-suspend: SUCCESS (3.000s)
[287.337791] [040/133] (733s left) kms_cursor_legacy (forked-bo)
[287.480181] Starting subtest: forked-bo
[287.482686] Starting dynamic subtest: pipe-A
[292.905281] Dynamic subtest pipe-A: SUCCESS (5.454s)
[292.916396] Starting dynamic subtest: pipe-B
[298.370667] Dynamic subtest pipe-B: SUCCESS (5.479s)
[298.382186] Starting dynamic subtest: pipe-C
[303.854516] Dynamic subtest pipe-C: SUCCESS (5.492s)
[303.874396] Starting dynamic subtest: pipe-D
[309.340765] Dynamic subtest pipe-D: SUCCESS (5.490s)
[309.359599] Starting dynamic subtest: all-pipes
[314.833381] Dynamic subtest all-pipes: SUCCESS (5.494s)
[314.835881] Subtest forked-bo: SUCCESS (27.420s)
[314.991371] [041/133] (705s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[315.092742] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[315.094991] Starting dynamic subtest: pipe-A
[315.115485] Dynamic subtest pipe-A: SKIP (0.018s)
[315.130200] Starting dynamic subtest: pipe-B
[315.148096] Dynamic subtest pipe-B: SKIP (0.032s)
[315.161315] Starting dynamic subtest: pipe-C
[315.177624] Dynamic subtest pipe-C: SKIP (0.031s)
[315.191180] Starting dynamic subtest: pipe-D
[315.210388] Dynamic subtest pipe-D: SKIP (0.031s)
[315.214931] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.114s)
[315.330318] [042/133] (705s left) gem_render_copy_redux (flink)
[315.388039] Starting subtest: flink
[316.124863] Subtest flink: SUCCESS (0.737s)
[316.288177] [043/133] (704s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[316.397946] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[316.401282] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[316.510389] [044/133] (704s left) prime_mmap (test_userptr)
[316.571038] Starting subtest: test_userptr
[316.572978] Starting dynamic subtest: test_userptr-smem
[316.574717] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[316.576550] Subtest test_userptr: SUCCESS (0.001s)
[316.703112] [045/133] (703s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[316.758948] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[316.868474] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.107s)
[316.962970] [046/133] (703s left) core_auth (many-magics)
[317.021308] Starting subtest: many-magics
[317.840748] Subtest many-magics: SUCCESS (0.822s)
[318.080161] [047/133] (702s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[318.136800] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[318.244577] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.107s)
[318.343118] [048/133] (702s left) kms_cursor_crc (cursor-sliding-max-size)
[318.665582] Starting subtest: cursor-sliding-max-size
[318.671898] Subtest cursor-sliding-max-size: SKIP (0.000s)
[318.815002] [049/133] (701s left) syncobj_wait (wait-all-for-submit-snapshot)
[318.873965] Starting subtest: wait-all-for-submit-snapshot
[318.954204] Subtest wait-all-for-submit-snapshot: SUCCESS (0.081s)
[319.042337] [050/133] (701s left) kms_invalid_mode (zero-vdisplay)
[319.145949] Starting subtest: zero-vdisplay
[319.148494] Starting dynamic subtest: pipe-A-eDP-1
[319.428669] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[319.438659] Starting dynamic subtest: pipe-B-eDP-1
[319.441055] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[319.450127] Starting dynamic subtest: pipe-C-eDP-1
[319.452014] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[319.460479] Starting dynamic subtest: pipe-D-eDP-1
[319.462356] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[319.464250] Subtest zero-vdisplay: SUCCESS (0.290s)
[320.284629] [051/133] (700s left) gem_userptr_blits (huge-split)
[320.370700] Starting subtest: huge-split
[320.375183] Subtest huge-split: SUCCESS (0.007s)
[320.527428] [052/133] (700s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[320.628845] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[320.632775] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[320.730715] [053/133] (700s left) gem_ctx_create (basic)
[320.796790] Starting subtest: basic
[320.799095] Subtest basic: SUCCESS (0.000s)
[321.000842] [054/133] (699s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[321.102803] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip
[322.096131] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (0.993s)
[322.264631] [055/133] (698s left) kms_lease (setcrtc-implicit-plane)
[322.369953] Starting subtest: setcrtc-implicit-plane
[322.371867] Starting dynamic subtest: pipe-A-eDP-1
[322.837540] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.463s)
[322.846466] Starting dynamic subtest: pipe-B-eDP-1
[323.978679] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.141s)
[323.990418] Starting dynamic subtest: pipe-C-eDP-1
[325.068745] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.091s)
[325.078987] Starting dynamic subtest: pipe-D-eDP-1
[326.172297] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.101s)
[326.174208] Subtest setcrtc-implicit-plane: SUCCESS (3.801s)
[326.988329] [056/133] (694s left) kms_psr (pr-sprite-mmap-cpu)
[327.089024] Starting subtest: pr-sprite-mmap-cpu
[327.093337] Subtest pr-sprite-mmap-cpu: SKIP (0.000s)
[327.175464] [057/133] (693s left) perf (gen12-unprivileged-single-ctx-counters)
[327.303077] Starting subtest: gen12-unprivileged-single-ctx-counters
[327.305145] Starting dynamic subtest: rcs0
[327.340522] Dynamic subtest rcs0: SUCCESS (0.037s)
[327.342807] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.039s)
[327.391244] [058/133] (693s left) gem_lmem_swapping (heavy-verify-random)
[327.433817] Subtest heavy-verify-random: SKIP (0.000s)
[327.480621] [059/133] (693s left) gem_busy (close-race)
[327.568232] Starting subtest: close-race
[352.704134] Subtest close-race: SUCCESS (25.148s)
[353.097905] [FACT gem_busy (close-race)] new: kernel.kmod_is_loaded.vgem: true
[353.103228] [060/133] (668s left) gem_exec_balancer (parallel-out-fence)
[353.410272] Starting subtest: parallel-out-fence
[354.494798] Subtest parallel-out-fence: SUCCESS (1.085s)
[354.642223] [061/133] (666s left) gem_ctx_shared (q-smoketest-all)
[354.713429] Starting subtest: Q-smoketest-all
[387.092035] Subtest Q-smoketest-all: SUCCESS (32.343s)
[388.884630] [062/133] (632s left) kms_psr (fbc-pr-primary-blt)
[388.997528] Starting subtest: fbc-pr-primary-blt
[389.001893] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[389.082559] [063/133] (632s left) api_intel_allocator (fork-simple-once)
[389.142794] Starting subtest: fork-simple-once
[389.156425] Subtest fork-simple-once: SUCCESS (0.015s)
[389.317700] [064/133] (632s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[389.417999] Starting subtest: flip-vs-dpms-on-nop-interruptible
[389.420219] Starting dynamic subtest: A-eDP1
[391.302474] Dynamic subtest A-eDP1: SUCCESS (1.882s)
[391.317566] Starting dynamic subtest: B-eDP1
[393.112378] Dynamic subtest B-eDP1: SUCCESS (1.806s)
[393.124583] Starting dynamic subtest: C-eDP1
[394.904263] Dynamic subtest C-eDP1: SUCCESS (1.790s)
[394.915963] Starting dynamic subtest: D-eDP1
[396.697154] Dynamic subtest D-eDP1: SUCCESS (1.790s)
[396.702263] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.282s)
[397.959488] [065/133] (623s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[398.093020] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[398.098233] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[398.236538] [066/133] (623s left) kms_selftest (drm_format)
[398.286048] Starting subtest: drm_format
[398.329050] Starting dynamic subtest: drm_test_format_block_width_invalid
[398.496112] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.165s)
[398.505704] Starting dynamic subtest: drm_test_format_block_width_one_plane
[398.654100] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.156s)
[398.665252] Starting dynamic subtest: drm_test_format_block_width_two_plane
[398.794064] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.140s)
[398.804972] Starting dynamic subtest: drm_test_format_block_width_three_plane
[398.936358] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.141s)
[398.947459] Starting dynamic subtest: drm_test_format_block_width_tiled
[399.055084] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.119s)
[399.064835] Starting dynamic subtest: drm_test_format_block_height_invalid
[399.211403] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.156s)
[399.221098] Starting dynamic subtest: drm_test_format_block_height_one_plane
[399.351790] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.138s)
[399.361252] Starting dynamic subtest: drm_test_format_block_height_two_plane
[399.481890] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.130s)
[399.491587] Starting dynamic subtest: drm_test_format_block_height_three_plane
[399.601270] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.117s)
[399.611013] Starting dynamic subtest: drm_test_format_block_height_tiled
[399.694493] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.093s)
[399.704338] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[399.848979] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.153s)
[399.859671] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[399.991226] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.141s)
[400.002444] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[400.151893] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.160s)
[400.162964] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[400.286893] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.134s)
[400.298160] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[400.436271] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.149s)
[400.447560] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[400.570832] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.134s)
[400.582281] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[400.685195] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.114s)
[400.696132] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[400.822134] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.135s)
[400.824204] Subtest drm_format: SUCCESS (2.532s)
[401.021154] [067/133] (620s left) gem_exec_schedule (deep)
[401.211340] Starting subtest: deep
[401.213798] Starting dynamic subtest: rcs0
[407.398926] Dynamic subtest rcs0: SKIP (6.183s)
[407.416235] Starting dynamic subtest: vcs0
[417.548233] Dynamic subtest vcs0: SUCCESS (10.151s)
[417.563488] Starting dynamic subtest: vcs1
[428.943771] Dynamic subtest vcs1: SUCCESS (11.395s)
[428.958052] Starting dynamic subtest: vecs0
[439.715443] Dynamic subtest vecs0: SUCCESS (10.769s)
[439.726189] Starting dynamic subtest: ccs0
[452.125785] Dynamic subtest ccs0: SUCCESS (12.412s)
[452.128325] Subtest deep: SUCCESS (50.919s)
[453.452612] [068/133] (568s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[453.561698] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[453.563970] Starting dynamic subtest: pipe-A
[454.736209] Dynamic subtest pipe-A: SUCCESS (1.177s)
[454.745942] Starting dynamic subtest: pipe-B
[456.986900] Dynamic subtest pipe-B: SUCCESS (2.251s)
[456.996425] Starting dynamic subtest: pipe-C
[458.175290] Dynamic subtest pipe-C: SUCCESS (1.187s)
[458.185174] Starting dynamic subtest: pipe-D
[459.366986] Dynamic subtest pipe-D: SUCCESS (1.191s)
[459.369292] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.809s)
[460.542070] [069/133] (561s left) gem_exec_flush (basic-batch-kernel-default-wb)
[460.617597] Starting subtest: basic-batch-kernel-default-wb
[467.637959] Subtest basic-batch-kernel-default-wb: SUCCESS (7.023s)
[467.834158] [070/133] (553s left) gem_mmap_wc (bad-object)
[467.902951] Subtest bad-object: SKIP (0.000s)
[467.984153] [071/133] (553s left) gem_basic (create-close)
[468.045761] Starting subtest: create-close
[468.050225] Subtest create-close: SUCCESS (0.000s)
[468.188433] [072/133] (553s left) gem_mmap_offset (partial-unmap)
[468.252304] Starting subtest: partial-unmap
[468.254279] Starting dynamic subtest: smem0
[468.678302] Dynamic subtest smem0: SUCCESS (0.426s)
[468.681310] Subtest partial-unmap: SUCCESS (0.427s)
[468.818474] [073/133] (552s left) gem_bad_reloc (negative-reloc-lut)
[468.892479] Subtest negative-reloc-lut: SKIP (0.000s)
[468.974539] [074/133] (552s left) gem_tiled_partial_pwrite_pread (writes)
[469.043874] Subtest writes: SKIP (0.000s)
[469.131062] [075/133] (552s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[469.239716] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[475.832620] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (6.598s)
[475.970029] [076/133] (545s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[476.084294] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[476.088363] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[476.207635] [077/133] (545s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[476.301921] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[476.304250] Starting dynamic subtest: pipe-A-eDP-1
[476.465922] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.153s)
[476.477560] Starting dynamic subtest: pipe-B-eDP-1
[476.497623] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.011s)
[476.512083] Starting dynamic subtest: pipe-C-eDP-1
[476.531080] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[476.542597] Starting dynamic subtest: pipe-D-eDP-1
[476.562888] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.012s)
[476.564802] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.192s)
[478.740220] [078/133] (543s left) kms_pm_rpm (modeset-stress-extra-wait)
[480.871160] Starting subtest: modeset-stress-extra-wait
[535.166096] Subtest modeset-stress-extra-wait: SUCCESS (54.282s)
[535.268180] [079/133] (486s left) kms_atomic (plane-immutable-zpos)
[535.366820] Starting subtest: plane-immutable-zpos
[535.369114] Starting dynamic subtest: pipe-A-eDP-1
[536.019627] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.652s)
[536.022237] Subtest plane-immutable-zpos: SUCCESS (0.653s)
[536.849651] [080/133] (485s left) syncobj_timeline (reset-unsignaled)
[536.914879] Starting subtest: reset-unsignaled
[536.917229] Subtest reset-unsignaled: SUCCESS (0.000s)
[537.039579] [081/133] (485s left) kms_color (gamma)
[537.146801] Starting subtest: gamma
[537.148651] Starting dynamic subtest: pipe-A-eDP-1
[537.864604] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.717s)
[537.874682] Starting dynamic subtest: pipe-B-eDP-1
[539.309273] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.444s)
[539.320129] Starting dynamic subtest: pipe-C-eDP-1
[540.675027] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.365s)
[540.687403] Starting dynamic subtest: pipe-D-eDP-1
[542.068927] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.390s)
[542.071166] Subtest gamma: SUCCESS (4.919s)
[542.947971] [082/133] (479s left) gem_pipe_control_store_loop (reused-buffer)
[543.021455] Starting subtest: reused-buffer
[545.174602] Subtest reused-buffer: SUCCESS (2.151s)
[545.339221] [083/133] (476s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[545.951764] Starting subtest: syncobj-backward-timeline-chain-engines
[546.108028] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.156s)
[547.834628] [084/133] (474s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[547.934901] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[547.939051] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[548.061372] [085/133] (474s left) kms_cursor_crc (cursor-dpms)
[548.204144] Starting subtest: cursor-dpms
[548.206523] Starting dynamic subtest: pipe-A-eDP-1
[551.262439] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.054s)
[551.273176] Starting dynamic subtest: pipe-D-eDP-1
[554.924585] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.662s)
[554.926805] Subtest cursor-dpms: SUCCESS (6.719s)
[555.763255] [086/133] (466s left) gen9_exec_parse (bb-oversize)
[555.825107] Subtest bb-oversize: SKIP (0.000s)
[555.888276] [087/133] (466s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[555.994674] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[555.996944] Starting dynamic subtest: pipe-A-eDP-1
[556.019069] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[556.029607] Starting dynamic subtest: pipe-B-eDP-1
[556.049841] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[556.058956] Starting dynamic subtest: pipe-C-eDP-1
[556.079512] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[556.088544] Starting dynamic subtest: pipe-D-eDP-1
[556.109521] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[556.113738] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[558.250035] [088/133] (464s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[558.348703] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[558.351042] Starting dynamic subtest: pipe-A-eDP-1
[558.410807] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.064s)
[558.731403] Starting dynamic subtest: pipe-B-eDP-1
[559.517058] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.795s)
[559.814805] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.466s)
[560.664062] [089/133] (461s left) gem_exec_whisper (basic-queues)
[560.732254] Starting subtest: basic-queues
[566.691138] Subtest basic-queues: SUCCESS (5.955s)
[566.885829] [090/133] (455s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[566.985225] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[567.104656] [091/133] (455s left) gem_eio (wait-immediate)
[567.340783] Starting subtest: wait-immediate
[567.736102] Subtest wait-immediate: SUCCESS (0.394s)
[567.923599] [092/133] (454s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[568.313568] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[569.116813] [093/133] (453s left) gem_spin_batch (spin-all-new)
[569.164678] Starting subtest: spin-all-new
[569.179985] Subtest spin-all-new: SUCCESS (0.014s)
[570.815445] [094/133] (451s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[570.925319] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[580.277091] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.354s)
[580.430014] [095/133] (442s left) kms_flip (dpms-off-confusion)
[580.531146] Starting subtest: dpms-off-confusion
[580.533437] Starting dynamic subtest: A-eDP1
[589.215098] Dynamic subtest A-eDP1: SUCCESS (8.683s)
[589.227233] Starting dynamic subtest: B-eDP1
[597.921254] Dynamic subtest B-eDP1: SUCCESS (8.705s)
[597.932264] Starting dynamic subtest: C-eDP1
[606.604322] Dynamic subtest C-eDP1: SUCCESS (8.682s)
[606.617252] Starting dynamic subtest: D-eDP1
[615.300130] Dynamic subtest D-eDP1: SUCCESS (8.695s)
[615.306060] Subtest dpms-off-confusion: SUCCESS (34.777s)
[616.541596] [096/133] (406s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[616.642671] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[616.646929] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[616.763064] [097/133] (406s left) gem_exec_schedule (noreorder-priority)
[616.941204] Starting subtest: noreorder-priority
[616.943960] Starting dynamic subtest: rcs0
[618.093613] Dynamic subtest rcs0: SUCCESS (1.154s)
[618.106503] Starting dynamic subtest: vcs0
[619.695450] Dynamic subtest vcs0: SUCCESS (1.598s)
[619.708757] Starting dynamic subtest: vcs1
[621.777590] Dynamic subtest vcs1: SUCCESS (2.080s)
[621.791042] Starting dynamic subtest: vecs0
[623.761229] Dynamic subtest vecs0: SUCCESS (1.982s)
[623.775353] Starting dynamic subtest: ccs0
[624.943954] Dynamic subtest ccs0: SUCCESS (1.182s)
[624.946715] Subtest noreorder-priority: SUCCESS (8.006s)
[625.146094] [098/133] (397s left) vgem_basic (bad-flag)
[625.193920] Starting subtest: bad-flag
[625.195856] Subtest bad-flag: SUCCESS (0.000s)
[625.263495] [099/133] (397s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[625.326453] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[625.328825] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[625.453028] [100/133] (397s left) kms_psr (fbc-psr-primary-mmap-gtt)
[625.568620] Starting subtest: fbc-psr-primary-mmap-gtt
[625.570829] Starting dynamic subtest: eDP-1
[625.574751] Dynamic subtest eDP-1: SKIP (0.000s)
[625.578756] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s)
[625.655629] [101/133] (397s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[625.772225] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[625.776194] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[625.921627] [102/133] (397s left) gem_ringfill (basic-all)
[631.747821] Starting subtest: basic-all
[632.912836] Subtest basic-all: SUCCESS (1.166s)
[633.091957] [103/133] (389s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[633.195446] Starting subtest: x-tiled-32bpp-rotate-270
[633.214664] Subtest x-tiled-32bpp-rotate-270: SKIP (0.018s)
[633.343046] [104/133] (389s left) prime_busy (before-wait)
[633.416270] Starting subtest: before-wait
[633.424146] Starting dynamic subtest: rcs0
[633.461993] Dynamic subtest rcs0: SUCCESS (0.041s)
[633.474199] Starting dynamic subtest: bcs0
[633.511387] Dynamic subtest bcs0: SUCCESS (0.047s)
[633.522245] Starting dynamic subtest: vcs0
[633.552622] Dynamic subtest vcs0: SUCCESS (0.041s)
[633.562996] Starting dynamic subtest: vcs1
[633.593151] Dynamic subtest vcs1: SUCCESS (0.040s)
[633.603426] Starting dynamic subtest: vecs0
[633.634053] Dynamic subtest vecs0: SUCCESS (0.040s)
[633.644297] Starting dynamic subtest: ccs0
[633.674951] Dynamic subtest ccs0: SUCCESS (0.040s)
[633.784132] Subtest before-wait: SUCCESS (0.369s)
[633.875554] [105/133] (389s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[633.995495] Starting subtest: cursorB-vs-flipB-varying-size
[634.000219] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[634.162863] [106/133] (389s left) drm_mm (drm_mm)
[634.205116] Starting subtest: drm_mm
[634.210448] Starting dynamic subtest: drm_test_mm_init
[634.340822] Dynamic subtest drm_test_mm_init: SUCCESS (0.129s)
[634.353036] Starting dynamic subtest: drm_test_mm_debug
[634.490177] Dynamic subtest drm_test_mm_debug: SUCCESS (0.149s)
[634.501913] Starting dynamic subtest: drm_test_mm_align32
[634.645850] Dynamic subtest drm_test_mm_align32: SUCCESS (0.155s)
[634.657797] Starting dynamic subtest: drm_test_mm_align64
[634.787040] Dynamic subtest drm_test_mm_align64: SUCCESS (0.141s)
[634.798484] Starting dynamic subtest: drm_test_mm_lowest
[634.937285] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.148s)
[634.948600] Starting dynamic subtest: drm_test_mm_highest
[635.091531] Dynamic subtest drm_test_mm_highest: SUCCESS (0.154s)
[635.093795] Subtest drm_mm: SUCCESS (0.886s)
[635.322330] [107/133] (387s left) i915_query (engine-info-invalid)
[635.393621] Starting subtest: engine-info-invalid
[635.395718] Subtest engine-info-invalid: SUCCESS (0.000s)
[635.516671] [108/133] (387s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[635.622504] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[642.062345] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.442s)
[642.226423] [109/133] (381s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[642.355230] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[643.303783] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.947s)
[644.138179] [110/133] (379s left) kms_feature_discovery (display-2x)
[644.239607] Starting subtest: display-2x
[644.243935] Subtest display-2x: SKIP (0.000s)
[644.327033] [111/133] (379s left) gem_ctx_isolation (dirty-create)
[644.392306] Starting subtest: dirty-create
[644.394699] Starting dynamic subtest: rcs0
[644.582861] Dynamic subtest rcs0: SUCCESS (0.190s)
[644.595025] Starting dynamic subtest: bcs0
[644.791414] Dynamic subtest bcs0: SUCCESS (0.208s)
[644.804097] Starting dynamic subtest: vcs0
[645.012800] Dynamic subtest vcs0: SUCCESS (0.220s)
[645.024744] Starting dynamic subtest: vcs1
[646.944745] Dynamic subtest vcs1: SUCCESS (1.931s)
[646.957132] Starting dynamic subtest: vecs0
[648.921759] Dynamic subtest vecs0: SUCCESS (1.976s)
[648.934289] Starting dynamic subtest: ccs0
[650.994802] Dynamic subtest ccs0: SUCCESS (2.072s)
[650.997211] Subtest dirty-create: SUCCESS (6.601s)
[651.274646] [112/133] (372s left) gem_tiled_wb
[651.427694] [113/133] (372s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[651.532599] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[651.536658] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[651.617520] [114/133] (371s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[651.720838] Starting subtest: crc-primary-suspend-y-tiled-ccs
[651.723099] Starting dynamic subtest: pipe-A-eDP-1
[651.732108] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[651.744121] Starting dynamic subtest: pipe-B-eDP-1
[651.754043] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[651.765752] Starting dynamic subtest: pipe-C-eDP-1
[651.774014] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[651.783712] Starting dynamic subtest: pipe-D-eDP-1
[651.792039] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[651.796254] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.005s)
[653.938350] [115/133] (369s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[654.032224] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[654.036590] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[654.164607] [116/133] (369s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[654.268267] Starting subtest: pr-overlay-plane-move-continuous-sf
[654.272684] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[654.349395] [117/133] (369s left) gem_exec_flush (basic-wb-rw-default)
[654.423975] Starting subtest: basic-wb-rw-default
[659.878820] Subtest basic-wb-rw-default: SUCCESS (5.457s)
[660.077758] [118/133] (363s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[660.191566] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[660.195538] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[660.329216] [119/133] (363s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[660.453323] Starting subtest: cursor-vs-flip-atomic-transitions
[690.351790] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (29.894s)
[691.271491] [120/133] (332s left) gem_softpin (invalid)
[691.346046] Starting subtest: invalid
[691.353981] Subtest invalid: SUCCESS (0.005s)
[691.522912] [121/133] (332s left) kms_pipe_stress (stress-xrgb8888-4tiled)
[691.620051] Starting subtest: stress-xrgb8888-4tiled
[697.466599] Subtest stress-xrgb8888-4tiled: SUCCESS (5.847s)
[697.516120] [122/133] (326s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[697.638171] Starting subtest: 2x-long-flip-vs-cursor-atomic
[697.642010] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s)
[697.810808] [123/133] (326s left) sw_sync (sync_merge_same)
[697.848099] Starting subtest: sync_merge_same
[697.849903] Subtest sync_merge_same: SUCCESS (0.000s)
[697.916930] [124/133] (326s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[698.013822] Starting subtest: y-tiled-16bpp-rotate-90
[698.017546] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[698.129989] [125/133] (325s left) kms_chamelium_color (ctm-negative)
[698.216906] Subtest ctm-negative: SKIP (0.000s)
[698.261871] [126/133] (325s left) gem_exec_flush (basic-wb-prw-default)
[698.330276] Starting subtest: basic-wb-prw-default
[703.796947] Subtest basic-wb-prw-default: SUCCESS (5.466s)
[703.997643] [127/133] (320s left) kms_psr (fbc-psr2-primary-page-flip)
[704.093841] Starting subtest: fbc-psr2-primary-page-flip
[704.096097] Starting dynamic subtest: eDP-1
[704.100222] Dynamic subtest eDP-1: SKIP (0.000s)
[704.104358] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[704.182567] [128/133] (319s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[704.284732] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[711.469064] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (7.187s)
[711.605947] [129/133] (312s left) gem_exec_schedule (u-semaphore-codependency)
[711.683930] Starting subtest: u-semaphore-codependency
[711.689287] Subtest u-semaphore-codependency: SUCCESS (0.012s)
[712.070861] [130/133] (312s left) gem_create (create-invalid-size)
[712.132824] Starting subtest: create-invalid-size
[712.135070] Subtest create-invalid-size: SUCCESS (0.000s)
[712.346751] [131/133] (311s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[712.447919] Starting subtest: yf-tiled-16bpp-rotate-90
[712.452602] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[712.566956] [132/133] (311s left) kms_psr (psr2-primary-render)
[712.671346] Starting subtest: psr2-primary-render
[712.673688] Starting dynamic subtest: eDP-1
[714.395027] Dynamic subtest eDP-1: SUCCESS (1.723s)
[714.396919] Subtest psr2-primary-render: SUCCESS (1.724s)
[715.235146] [133/133] (309s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[715.338027] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[715.342085] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[715.467944] 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.