[57.699507] Initializing watchdogs
[57.699556]   /dev/watchdog0
[57.714737] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.719659] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.722150] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.725397] [001/133] (960s left) kms_big_fb (yf-tiled-8bpp-rotate-180)
[57.850870] Starting subtest: yf-tiled-8bpp-rotate-180
[57.855147] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s)
[57.939624] [002/133] (960s left) gem_mmap_gtt (pf-nonblock)
[57.988565] Subtest pf-nonblock: SKIP (0.000s)
[58.048169] [003/133] (960s left) gem_tiled_partial_pwrite_pread (reads)
[58.101514] Subtest reads: SKIP (0.000s)
[58.169152] [004/133] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[58.265480] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[58.269662] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[58.355319] [005/133] (960s left) kms_flip (blocking-absolute-wf_vblank)
[58.441955] Starting subtest: blocking-absolute-wf_vblank
[58.444255] Starting dynamic subtest: A-eDP1
[67.261356] Dynamic subtest A-eDP1: SUCCESS (8.825s)
[67.269977] Starting dynamic subtest: B-eDP1
[75.989264] Dynamic subtest B-eDP1: SUCCESS (8.729s)
[75.998768] Starting dynamic subtest: C-eDP1
[84.712932] Dynamic subtest C-eDP1: SUCCESS (8.723s)
[84.722706] Starting dynamic subtest: D-eDP1
[93.443026] Dynamic subtest D-eDP1: SUCCESS (8.730s)
[93.447683] Subtest blocking-absolute-wf_vblank: SUCCESS (35.018s)
[94.655649] [006/133] (923s left) kms_atomic_transition (plane-toggle-modeset-transition)
[94.766394] Starting subtest: plane-toggle-modeset-transition
[94.768401] Starting dynamic subtest: pipe-A-eDP-1
[107.528190] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.764s)
[107.538809] Starting dynamic subtest: pipe-B-eDP-1
[119.970418] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.439s)
[119.973032] Subtest plane-toggle-modeset-transition: SUCCESS (25.208s)
[120.794017] [007/133] (897s left) gem_busy (semaphore)
[120.987426] Subtest semaphore: SKIP (0.000s)
[121.212171] [008/133] (897s left) kms_vblank (wait-forked-hang)
[121.304728] Starting subtest: wait-forked-hang
[121.306924] Starting dynamic subtest: pipe-A-eDP-1
[147.743789] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.439s)
[147.757539] Starting dynamic subtest: pipe-D-eDP-1
[162.710191] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.962s)
[162.712449] Subtest wait-forked-hang: SUCCESS (41.406s)
[163.567702] [009/133] (854s left) syncobj_timeline (32bits-limit)
[163.638894] Starting subtest: 32bits-limit
[163.643469] Subtest 32bits-limit: SUCCESS (0.002s)
[163.781407] [010/133] (854s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[163.875447] Starting subtest: fbcpsr-modesetfrombusy
[170.039928] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.169s)
[170.165349] [011/133] (848s left) kms_atomic (plane-primary-legacy)
[170.267195] Starting subtest: plane-primary-legacy
[170.268970] Starting dynamic subtest: pipe-A-eDP-1
[170.711078] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.443s)
[170.713409] Subtest plane-primary-legacy: SUCCESS (0.444s)
[171.545164] [012/133] (847s left) gem_mmap (pf-nonblock)
[171.609854] Subtest pf-nonblock: SKIP (0.000s)
[171.682994] [013/133] (847s left) kms_flip (2x-plain-flip-ts-check)
[171.775927] Starting subtest: 2x-plain-flip-ts-check
[171.786871] Subtest 2x-plain-flip-ts-check: SKIP (0.011s)
[171.900212] [014/133] (846s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[172.012227] Starting subtest: flip-vs-cursor-busy-crc-atomic
[172.839535] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.825s)
[173.679199] [015/133] (845s left) kms_content_protection (legacy)
[173.816177] Starting subtest: legacy
[173.820925] Subtest legacy: SKIP (0.000s)
[173.933448] [016/133] (844s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[173.989783] Starting subtest: y-tiled-ccs-to-x-tiled
[173.994039] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[174.184324] [017/133] (844s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[174.282195] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[174.284601] Starting dynamic subtest: pipe-A-eDP-1
[174.368932] Dynamic subtest pipe-A-eDP-1: SKIP (0.089s)
[174.378292] Starting dynamic subtest: pipe-B-eDP-1
[175.557743] Dynamic subtest pipe-B-eDP-1: SKIP (1.188s)
[175.562211] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.278s)
[176.757980] [018/133] (842s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt)
[176.867126] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt
[176.871217] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[176.977229] [019/133] (841s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[177.376268] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[178.155237] [020/133] (840s left) syncobj_wait (invalid-reset-illegal-handle)
[178.217110] Starting subtest: invalid-reset-illegal-handle
[178.219109] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[178.315282] [021/133] (840s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[178.408537] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[185.008263] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.602s)
[185.143620] [022/133] (833s left) vgem_basic (sysfs)
[185.260965] Starting subtest: sysfs
[185.263170] Subtest sysfs: SUCCESS (0.000s)
[185.317459] [FACT vgem_basic (sysfs)] new: kernel.kmod_is_loaded.vgem: true
[185.320830] [023/133] (833s left) i915_drm_fdinfo (idle)
[185.358713] Starting subtest: idle
[185.361071] Starting dynamic subtest: rcs0
[185.933051] Dynamic subtest rcs0: SUCCESS (0.575s)
[185.943739] Starting dynamic subtest: bcs0
[186.440349] Dynamic subtest bcs0: SUCCESS (0.504s)
[186.450711] Starting dynamic subtest: vcs0
[186.945357] Dynamic subtest vcs0: SUCCESS (0.504s)
[186.955902] Starting dynamic subtest: vcs1
[187.450357] Dynamic subtest vcs1: SUCCESS (0.504s)
[187.460773] Starting dynamic subtest: vecs0
[187.955402] Dynamic subtest vecs0: SUCCESS (0.503s)
[187.966066] Starting dynamic subtest: ccs0
[188.460551] Dynamic subtest ccs0: SUCCESS (0.504s)
[188.463688] Subtest idle: SUCCESS (3.102s)
[188.536755] [024/133] (830s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[188.638401] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[188.642847] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[188.762372] [025/133] (830s left) gem_exec_schedule (preempt-hang)
[188.941624] Starting subtest: preempt-hang
[188.944152] Starting dynamic subtest: rcs0
[189.177593] Dynamic subtest rcs0: SUCCESS (0.239s)
[189.187790] Starting dynamic subtest: bcs0
[189.412991] Dynamic subtest bcs0: SUCCESS (0.235s)
[189.424261] Starting dynamic subtest: vcs0
[189.635736] Dynamic subtest vcs0: SUCCESS (0.224s)
[189.645333] Starting dynamic subtest: vcs1
[189.857211] Dynamic subtest vcs1: SUCCESS (0.218s)
[189.866696] Starting dynamic subtest: vecs0
[190.079490] Dynamic subtest vecs0: SUCCESS (0.221s)
[190.089060] Starting dynamic subtest: ccs0
[190.306994] Dynamic subtest ccs0: SUCCESS (0.227s)
[190.309359] Subtest preempt-hang: SUCCESS (1.369s)
[191.024704] [026/133] (828s left) gem_ctx_engines (independent)
[191.088736] Starting subtest: independent
[191.091116] Starting dynamic subtest: rcs0
[191.290649] Dynamic subtest rcs0: SUCCESS (0.200s)
[191.302758] Starting dynamic subtest: bcs0
[191.529541] Dynamic subtest bcs0: SUCCESS (0.239s)
[191.539456] Starting dynamic subtest: vcs0
[191.725957] Dynamic subtest vcs0: SUCCESS (0.196s)
[191.735635] Starting dynamic subtest: vcs1
[191.937734] Dynamic subtest vcs1: SUCCESS (0.211s)
[191.947317] Starting dynamic subtest: vecs0
[192.152687] Dynamic subtest vecs0: SUCCESS (0.214s)
[192.162564] Starting dynamic subtest: ccs0
[192.381109] Dynamic subtest ccs0: SUCCESS (0.228s)
[192.391423] Starting dynamic subtest: all-engines
[193.323323] Dynamic subtest all-engines: SUCCESS (0.942s)
[193.325832] Subtest independent: SUCCESS (2.234s)
[194.891030] [027/133] (824s left) kms_addfb_basic (bad-pitch-999)
[194.937804] Starting subtest: bad-pitch-999
[194.940073] Subtest bad-pitch-999: SUCCESS (0.000s)
[195.088790] [028/133] (824s left) gem_exec_params (cliprects_ptr-dirt)
[195.142323] Starting subtest: cliprects_ptr-dirt
[195.144787] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[195.262930] [029/133] (824s left) api_intel_bb (blit-noreloc-keep-cache)
[195.322741] Starting subtest: blit-noreloc-keep-cache
[195.331829] Subtest blit-noreloc-keep-cache: SUCCESS (0.010s)
[195.447941] [030/133] (823s left) kms_invalid_mode (bad-vtotal)
[195.537986] Starting subtest: bad-vtotal
[195.540390] Starting dynamic subtest: pipe-A-eDP-1
[195.825613] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s)
[195.834236] Starting dynamic subtest: pipe-B-eDP-1
[195.836152] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[195.845821] Starting dynamic subtest: pipe-C-eDP-1
[195.848472] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[195.855808] Starting dynamic subtest: pipe-D-eDP-1
[195.858199] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[195.860361] Subtest bad-vtotal: SUCCESS (0.292s)
[196.654206] [031/133] (822s left) gem_workarounds (basic-read-fd)
[196.722725] Starting subtest: basic-read-fd
[196.732742] Subtest basic-read-fd: SUCCESS (0.011s)
[196.902795] [032/133] (822s left) gem_readwrite (write-bad-handle)
[196.967166] Subtest write-bad-handle: SKIP (0.000s)
[197.024639] [033/133] (822s left) prime_busy (hang-wait)
[197.089051] Starting subtest: hang-wait
[197.091511] Starting dynamic subtest: rcs0
[223.410553] Dynamic subtest rcs0: SUCCESS (26.317s)
[223.419387] Starting dynamic subtest: bcs0
[230.553477] Dynamic subtest bcs0: SUCCESS (7.141s)
[230.562649] Starting dynamic subtest: vcs0
[237.544090] Dynamic subtest vcs0: SUCCESS (6.989s)
[237.553420] Starting dynamic subtest: vcs1
[244.583590] Dynamic subtest vcs1: SUCCESS (7.039s)
[244.591369] Starting dynamic subtest: vecs0
[251.554893] Dynamic subtest vecs0: SUCCESS (6.969s)
[251.567505] Starting dynamic subtest: ccs0
[265.461121] Dynamic subtest ccs0: SUCCESS (13.902s)
[265.463833] Subtest hang-wait: SUCCESS (68.369s)
[265.590426] [034/133] (754s left) gem_ctx_persistence (legacy-engines-persistence)
[265.656339] Starting subtest: legacy-engines-persistence
[265.658747] Starting dynamic subtest: render
[266.457973] Dynamic subtest render: SUCCESS (0.801s)
[266.471098] Starting dynamic subtest: bsd1
[267.214753] Dynamic subtest bsd1: SUCCESS (0.755s)
[267.225479] Starting dynamic subtest: bsd2
[267.964845] Dynamic subtest bsd2: SUCCESS (0.748s)
[267.974625] Starting dynamic subtest: blt
[268.758988] Dynamic subtest blt: SUCCESS (0.792s)
[268.769626] Starting dynamic subtest: vebox
[269.517924] Dynamic subtest vebox: SUCCESS (0.757s)
[269.520662] Subtest legacy-engines-persistence: SUCCESS (3.862s)
[269.608391] [035/133] (750s left) gem_mmap_gtt (coherency)
[269.674312] Subtest coherency: SKIP (0.000s)
[269.741277] [036/133] (749s left) kms_rotation_crc (primary-rotation-90)
[269.838717] Starting subtest: primary-rotation-90
[269.843117] Subtest primary-rotation-90: SKIP (0.001s)
[269.913362] [037/133] (749s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[270.014704] Starting subtest: psr-2p-primscrn-cur-indfb-move
[270.019161] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[270.127167] [038/133] (749s left) gem_exec_suspend (basic-s3-devices)
[270.180517] Starting subtest: basic-S3-devices
[270.183054] Starting dynamic subtest: smem
[281.942443] Dynamic subtest smem: SUCCESS (11.759s)
[281.945420] Subtest basic-S3-devices: SUCCESS (11.760s)
[291.156164] [039/133] (737s left) kms_cursor_crc (cursor-sliding-32x32)
[291.332277] Starting subtest: cursor-sliding-32x32
[291.393059] Subtest cursor-sliding-32x32: SKIP (0.057s)
[291.703246] [040/133] (737s left) perf_pmu (busy-idle-check-all)
[291.743777] Starting subtest: busy-idle-check-all
[291.746036] Starting dynamic subtest: rcs0
[292.395239] Dynamic subtest rcs0: SUCCESS (0.652s)
[292.407093] Starting dynamic subtest: bcs0
[293.048066] Dynamic subtest bcs0: SUCCESS (0.652s)
[293.059893] Starting dynamic subtest: vcs0
[294.934312] Dynamic subtest vcs0: SUCCESS (1.883s)
[294.944566] Starting dynamic subtest: vcs1
[296.917871] Dynamic subtest vcs1: SUCCESS (1.982s)
[296.929381] Starting dynamic subtest: vecs0
[298.902367] Dynamic subtest vecs0: SUCCESS (1.982s)
[298.914268] Starting dynamic subtest: ccs0
[299.558243] Dynamic subtest ccs0: SUCCESS (0.656s)
[299.560629] Subtest busy-idle-check-all: SUCCESS (7.816s)
[299.649446] [041/133] (729s left) gem_exec_flush (basic-uc-rw-default)
[299.713576] Starting subtest: basic-uc-rw-default
[305.175232] Subtest basic-uc-rw-default: SUCCESS (5.461s)
[305.370272] [042/133] (723s left) kms_busy (extended-pageflip-hang-oldfb)
[305.462856] Starting subtest: extended-pageflip-hang-oldfb
[305.465169] Starting dynamic subtest: pipe-A
[305.870975] Dynamic subtest pipe-A: SUCCESS (0.407s)
[305.880884] Starting dynamic subtest: pipe-D
[306.964596] Dynamic subtest pipe-D: SUCCESS (1.091s)
[306.967012] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.502s)
[307.811425] [043/133] (721s left) gem_exec_whisper (basic-fds)
[307.866975] Starting subtest: basic-fds
[313.905637] Subtest basic-fds: SUCCESS (6.036s)
[314.088735] [044/133] (714s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[314.198809] Starting subtest: psr2-primary-plane-update-sf-dmg-area
[314.201134] Starting dynamic subtest: pipe-A-eDP-1
[320.079516] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.883s)
[320.092628] Starting dynamic subtest: pipe-B-eDP-1
[326.744987] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.667s)
[326.747449] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (12.554s)
[327.611742] [045/133] (701s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[327.734478] Starting subtest: y-tiled-8bpp-rotate-0
[327.738483] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[327.830383] [046/133] (701s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[327.928752] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[335.635246] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.710s)
[335.764046] [047/133] (693s left) kms_flip (2x-flip-vs-dpms)
[335.851175] Starting subtest: 2x-flip-vs-dpms
[335.863289] Subtest 2x-flip-vs-dpms: SKIP (0.011s)
[335.948392] [048/133] (693s left) kms_plane_multiple (2x-tiling-none)
[336.040677] Starting subtest: 2x-tiling-none
[336.045130] Subtest 2x-tiling-none: SKIP (0.000s)
[336.132416] [049/133] (693s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[336.186868] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[336.191355] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[336.369021] [050/133] (692s left) kms_prop_blob (blob-prop-core)
[336.426276] Starting subtest: blob-prop-core
[336.428470] Subtest blob-prop-core: SUCCESS (0.000s)
[336.515176] [051/133] (692s left) api_intel_bb (intel-bb-blit-y)
[336.570832] Starting subtest: intel-bb-blit-y
[340.458034] Subtest intel-bb-blit-y: SUCCESS (3.887s)
[340.569824] [052/133] (688s left) gem_exec_fence (syncobj-wait)
[341.059060] Starting subtest: syncobj-wait
[342.964769] Subtest syncobj-wait: SUCCESS (1.904s)
[343.311856] [053/133] (686s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[343.404935] Starting subtest: multiplane-rotation-cropping-bottom
[360.807280] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.404s)
[360.923199] [054/133] (668s left) gem_ctx_param (vm)
[361.003625] Starting subtest: vm
[361.055669] Subtest vm: SUCCESS (0.052s)
[361.188944] [055/133] (668s left) kms_universal_plane (universal-plane-sanity)
[361.283417] Starting subtest: universal-plane-sanity
[361.285252] Starting dynamic subtest: pipe-A-eDP-1
[361.892851] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.608s)
[361.902604] Starting dynamic subtest: pipe-B-eDP-1
[363.086184] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.192s)
[363.098879] Starting dynamic subtest: pipe-C-eDP-1
[364.294122] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.202s)
[364.303458] Starting dynamic subtest: pipe-D-eDP-1
[365.532542] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.237s)
[365.534697] Subtest universal-plane-sanity: SUCCESS (4.248s)
[366.403213] [056/133] (663s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[366.506675] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[366.510910] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[366.623084] [057/133] (662s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[366.718466] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[370.794327] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.078s)
[371.990092] [058/133] (657s left) i915_pm_rpm (gem-execbuf)
[374.009194] Starting subtest: gem-execbuf
[374.011541] Starting dynamic subtest: smem0
[375.437831] Dynamic subtest smem0: SUCCESS (1.428s)
[375.440174] Subtest gem-execbuf: SUCCESS (1.429s)
[375.527459] [059/133] (654s left) kms_cursor_legacy (single-move)
[375.636458] Starting subtest: single-move
[375.638660] Starting dynamic subtest: pipe-A
[381.018996] Dynamic subtest pipe-A: SUCCESS (5.379s)
[381.030974] Starting dynamic subtest: pipe-B
[386.403383] Dynamic subtest pipe-B: SUCCESS (5.380s)
[386.414953] Starting dynamic subtest: pipe-C
[391.785671] Dynamic subtest pipe-C: SUCCESS (5.380s)
[391.796917] Starting dynamic subtest: pipe-D
[397.168686] Dynamic subtest pipe-D: SUCCESS (5.380s)
[397.179923] Starting dynamic subtest: all-pipes
[402.557945] Dynamic subtest all-pipes: SUCCESS (5.387s)
[402.560622] Subtest single-move: SUCCESS (26.919s)
[402.715862] [060/133] (627s left) i915_module_load (resize-bar)
[402.779863] Starting subtest: resize-bar
[402.789291] Subtest resize-bar: SKIP (0.010s)
[402.843977] [061/133] (626s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[402.959589] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[409.572268] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.616s)
[409.665426] [062/133] (620s left) gem_sync (basic-store-each)
[409.740108] Starting subtest: basic-store-each
[412.073403] Subtest basic-store-each: SUCCESS (2.342s)
[412.268381] [063/133] (617s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[412.324336] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[412.326584] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[412.416874] [064/133] (617s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[412.513806] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[412.518087] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[412.634942] [065/133] (617s left) gem_ctx_bad_destroy (invalid-default-ctx)
[412.687937] Starting subtest: invalid-default-ctx
[412.690342] Subtest invalid-default-ctx: SUCCESS (0.000s)
[412.775529] [066/133] (617s left) kms_big_fb (linear-8bpp-rotate-90)
[412.865736] Starting subtest: linear-8bpp-rotate-90
[412.889270] Subtest linear-8bpp-rotate-90: SKIP (0.021s)
[413.003160] [067/133] (617s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[413.093834] Starting subtest: fbc-rgb565-draw-pwrite
[417.743067] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.652s)
[418.939394] [068/133] (611s left) kms_pipe_crc_basic (suspend-read-crc)
[419.034585] Starting subtest: suspend-read-crc
[419.036675] Starting dynamic subtest: pipe-A-eDP-1
[436.801528] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.948s)
[436.810841] Starting dynamic subtest: pipe-B-eDP-1
[455.807744] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.583s)
[455.818166] Starting dynamic subtest: pipe-C-eDP-1
[474.768927] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.560s)
[474.780066] Starting dynamic subtest: pipe-D-eDP-1
[493.762794] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.474s)
[493.765152] Subtest suspend-read-crc: SUCCESS (13.570s)
[503.626716] [069/133] (535s left) kms_cursor_crc (cursor-offscreen-32x10)
[503.803526] Starting subtest: cursor-offscreen-32x10
[503.851177] Subtest cursor-offscreen-32x10: SKIP (0.042s)
[504.129589] [070/133] (535s left) gem_exec_balancer (smoke)
[504.181618] Starting subtest: smoke
[526.786937] Subtest smoke: SUCCESS (22.610s)
[528.208151] [071/133] (511s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[528.255860] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[528.258115] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[528.369701] [072/133] (510s left) kms_plane (planar-pixel-format-settings)
[528.460716] Starting subtest: planar-pixel-format-settings
[528.527182] Subtest planar-pixel-format-settings: SUCCESS (0.067s)
[528.635104] [073/133] (510s left) kms_plane (pixel-format-yf-tiled-ccs-modifier-source-clamping)
[528.728764] Starting subtest: pixel-format-yf-tiled-ccs-modifier-source-clamping
[528.732970] Subtest pixel-format-yf-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[528.803838] [074/133] (510s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[528.907075] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[528.909283] Starting dynamic subtest: pipe-A-eDP-1
[528.929435] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[528.941246] Starting dynamic subtest: pipe-B-eDP-1
[528.960380] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[528.969468] Starting dynamic subtest: pipe-C-eDP-1
[528.988549] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[528.998798] Starting dynamic subtest: pipe-D-eDP-1
[529.018048] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[529.020180] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.011s)
[531.242100] [075/133] (508s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[531.338668] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[531.342968] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[531.450130] [076/133] (507s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[531.516637] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[531.580550] [077/133] (507s left) kms_psr (pr-sprite-blt)
[531.672053] Starting subtest: pr-sprite-blt
[531.676297] Subtest pr-sprite-blt: SKIP (0.000s)
[531.749522] [078/133] (507s left) kms_chamelium_color (ctm-max)
[531.856600] Subtest ctm-max: SKIP (0.000s)
[531.907335] [079/133] (507s left) syncobj_wait (single-wait-submitted)
[531.970387] Starting subtest: single-wait-submitted
[532.080008] Subtest single-wait-submitted: SUCCESS (0.109s)
[532.170772] [080/133] (507s left) gem_spin_batch (resubmit-new)
[532.237126] Starting subtest: resubmit-new
[532.239528] Starting dynamic subtest: rcs0
[532.245199] Dynamic subtest rcs0: SUCCESS (0.008s)
[532.256440] Starting dynamic subtest: bcs0
[532.258320] Dynamic subtest bcs0: SUCCESS (0.004s)
[532.267903] Starting dynamic subtest: vcs0
[532.270105] Dynamic subtest vcs0: SUCCESS (0.004s)
[532.279196] Starting dynamic subtest: vcs1
[532.281106] Dynamic subtest vcs1: SUCCESS (0.004s)
[532.289951] Starting dynamic subtest: vecs0
[532.291780] Dynamic subtest vecs0: SUCCESS (0.004s)
[532.300699] Starting dynamic subtest: ccs0
[532.302550] Dynamic subtest ccs0: SUCCESS (0.004s)
[532.304444] Subtest resubmit-new: SUCCESS (0.031s)
[534.131763] [081/133] (505s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[534.265203] Starting subtest: 2x-long-flip-vs-cursor-legacy
[534.269532] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.001s)
[534.408607] [082/133] (505s left) gem_set_tiling_vs_pwrite
[534.542307] [083/133] (505s left) gem_mmap_gtt (cpuset-medium-copy)
[534.605540] Subtest cpuset-medium-copy: SKIP (0.000s)
[534.685149] [084/133] (505s left) gem_softpin (evict-active)
[534.750977] Starting subtest: evict-active
[534.757159] Subtest evict-active: SUCCESS (0.006s)
[534.892282] [085/133] (505s left) kms_feature_discovery (display-3x)
[534.994478] Starting subtest: display-3x
[534.998740] Subtest display-3x: SKIP (0.000s)
[535.103620] [086/133] (504s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[535.210095] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[535.213354] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[535.285293] [087/133] (504s left) kms_color_pipeline (plane-lut1d-lut1d)
[535.382455] Starting subtest: plane-lut1d-lut1d
[535.562619] Starting dynamic subtest: pipe-A-plane-0
[535.739996] Dynamic subtest pipe-A-plane-0: SUCCESS (0.177s)
[535.749720] Starting dynamic subtest: pipe-A-plane-1
[535.907101] Dynamic subtest pipe-A-plane-1: SUCCESS (0.166s)
[535.916949] Starting dynamic subtest: pipe-A-plane-2
[536.096452] Dynamic subtest pipe-A-plane-2: SUCCESS (0.188s)
[537.244219] Starting dynamic subtest: pipe-B-plane-0
[537.402892] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s)
[537.412985] Starting dynamic subtest: pipe-B-plane-1
[537.570889] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s)
[537.581056] Starting dynamic subtest: pipe-B-plane-2
[537.736230] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[538.913778] Starting dynamic subtest: pipe-C-plane-0
[539.059850] Dynamic subtest pipe-C-plane-0: SUCCESS (0.155s)
[539.069738] Starting dynamic subtest: pipe-C-plane-1
[539.215200] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s)
[539.224985] Starting dynamic subtest: pipe-C-plane-2
[539.370776] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s)
[540.529600] Starting dynamic subtest: pipe-D-plane-0
[540.675005] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s)
[540.688776] Starting dynamic subtest: pipe-D-plane-1
[540.843305] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s)
[540.855943] Starting dynamic subtest: pipe-D-plane-2
[541.019670] Dynamic subtest pipe-D-plane-2: SUCCESS (0.177s)
[541.310838] Subtest plane-lut1d-lut1d: SUCCESS (5.929s)
[542.113319] [088/133] (497s left) gem_mmap_wc (write-gtt-read-wc)
[542.170560] Subtest write-gtt-read-wc: SKIP (0.000s)
[542.247267] [089/133] (497s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[542.346405] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[543.436032] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.090s)
[543.573995] [090/133] (496s left) gem_exec_fence (invalid-timeline-fence-array)
[544.184188] Starting subtest: invalid-timeline-fence-array
[544.190685] Subtest invalid-timeline-fence-array: SUCCESS (0.005s)
[545.096177] [091/133] (495s left) kms_lease (lease-unleased-crtc)
[545.190569] Starting subtest: lease-unleased-crtc
[545.192888] Starting dynamic subtest: pipe-A-eDP-1
[545.478114] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s)
[545.489796] Starting dynamic subtest: pipe-B-eDP-1
[546.264045] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.783s)
[546.276798] Starting dynamic subtest: pipe-C-eDP-1
[546.279098] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[546.288596] Starting dynamic subtest: pipe-D-eDP-1
[546.291022] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[546.293202] Subtest lease-unleased-crtc: SUCCESS (1.085s)
[546.643300] [092/133] (493s left) kms_pm_dc (dc6-dpms)
[547.745028] Starting subtest: dc6-dpms
[549.819677] Subtest dc6-dpms: SUCCESS (2.074s)
[549.910173] [093/133] (490s left) gem_exec_balancer (parallel-bb-first)
[550.168989] Starting subtest: parallel-bb-first
[551.127735] Subtest parallel-bb-first: SUCCESS (0.959s)
[552.105688] [094/133] (488s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[552.213807] Starting subtest: fbc-psr2-sprite-mmap-cpu
[552.216174] Starting dynamic subtest: eDP-1
[552.220499] Dynamic subtest eDP-1: SKIP (0.000s)
[552.224903] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[552.306388] [095/133] (488s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[552.399271] Starting subtest: fbc-psr2-cursor-mmap-cpu
[552.401573] Starting dynamic subtest: eDP-1
[552.406392] Dynamic subtest eDP-1: SKIP (0.000s)
[552.411289] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.001s)
[552.476063] [096/133] (487s left) kms_fbcon_fbt (fbc)
[552.539570] Starting subtest: fbc
[558.929228] Subtest fbc: SUCCESS (6.388s)
[560.006184] [097/133] (480s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[560.112127] Starting subtest: 4-tiled-64bpp-rotate-90
[560.132807] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.020s)
[560.237740] [098/133] (480s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[560.334163] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[560.338075] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[560.458516] [099/133] (480s left) gen9_exec_parse (allowed-all)
[560.521173] Subtest allowed-all: SKIP (0.000s)
[560.589259] [100/133] (480s left) kms_psr (psr-cursor-plane-onoff)
[560.678228] Starting subtest: psr-cursor-plane-onoff
[560.680427] Starting dynamic subtest: eDP-1
[562.411062] Dynamic subtest eDP-1: SUCCESS (1.733s)
[562.413317] Subtest psr-cursor-plane-onoff: SUCCESS (1.734s)
[563.279298] [101/133] (477s left) core_setmaster (master-drop-set-shared-fd)
[563.348688] Starting subtest: master-drop-set-shared-fd
[563.359385] Subtest master-drop-set-shared-fd: SUCCESS (0.011s)
[563.397622] [102/133] (477s left) kms_pm_rpm (legacy-planes-dpms)
[565.222693] Starting subtest: legacy-planes-dpms
[565.225200] Starting dynamic subtest: plane-65
[573.529193] Dynamic subtest plane-65: SUCCESS (8.310s)
[573.545223] Starting dynamic subtest: plane-95
[581.926412] Dynamic subtest plane-95: SUCCESS (8.395s)
[581.938825] Starting dynamic subtest: plane-125
[590.219444] Dynamic subtest plane-125: SUCCESS (8.291s)
[590.232436] Starting dynamic subtest: plane-135
[598.619971] Dynamic subtest plane-135: SUCCESS (8.397s)
[598.622776] Subtest legacy-planes-dpms: SUCCESS (33.405s)
[599.007242] [103/133] (441s left) perf_pmu (interrupts)
[599.048777] Starting subtest: interrupts
[600.142097] Subtest interrupts: SUCCESS (1.091s)
[600.252885] [104/133] (440s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[600.312136] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[600.316226] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[600.498247] [105/133] (440s left) gem_userptr_blits (unsync-unmap)
[600.561628] Subtest unsync-unmap: SKIP (0.000s)
[600.690387] [106/133] (440s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[600.781267] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[600.783549] Starting dynamic subtest: pipe-A-eDP-1
[600.806687] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[600.821125] Starting dynamic subtest: pipe-B-eDP-1
[600.843533] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[600.855629] Starting dynamic subtest: pipe-C-eDP-1
[600.877857] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[600.889016] Starting dynamic subtest: pipe-D-eDP-1
[600.911127] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[600.915131] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[603.068135] [107/133] (437s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[603.172199] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[603.176183] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[603.247718] [108/133] (437s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[603.340186] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[603.342066] Starting dynamic subtest: pipe-A-eDP-1
[603.764278] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.425s)
[603.776852] Starting dynamic subtest: pipe-B-eDP-1
[603.797426] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.003s)
[603.807453] Starting dynamic subtest: pipe-C-eDP-1
[603.826211] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[603.835238] Starting dynamic subtest: pipe-D-eDP-1
[603.854478] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[603.856397] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.440s)
[606.032915] [109/133] (434s left) syncobj_timeline (signal)
[606.091927] Starting subtest: signal
[606.094261] Subtest signal: SUCCESS (0.000s)
[606.211774] [110/133] (434s left) gem_exec_schedule (u-semaphore-resolve)
[606.287242] Starting subtest: u-semaphore-resolve
[606.321326] Subtest u-semaphore-resolve: SUCCESS (0.042s)
[606.654971] [111/133] (434s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[606.751298] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[611.155837] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.407s)
[612.319540] [112/133] (428s left) syncobj_wait (wait-for-submit-snapshot)
[612.381252] Starting subtest: wait-for-submit-snapshot
[612.461807] Subtest wait-for-submit-snapshot: SUCCESS (0.081s)
[612.537935] [113/133] (428s left) gem_exec_whisper (basic-queues-forked-all)
[612.606903] Starting subtest: basic-queues-forked-all
[632.320466] Subtest basic-queues-forked-all: SUCCESS (19.680s)
[632.491941] [114/133] (408s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[632.581796] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[632.585828] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.000s)
[632.654470] [115/133] (408s left) gem_render_copy_redux (flink)
[632.711374] Starting subtest: flink
[633.479470] Subtest flink: SUCCESS (0.768s)
[633.605361] [116/133] (407s left) gem_exec_alignment (forked)
[633.666347] Starting subtest: forked
[673.424524] Subtest forked: SUCCESS (39.755s)
[673.510872] [117/133] (367s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[673.666828] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[673.671125] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[673.770483] [118/133] (367s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[673.869773] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[673.874143] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[673.968548] [119/133] (367s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[674.349039] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[675.207791] [120/133] (366s left) gem_linear_blits (normal)
[675.395858] Starting subtest: normal
[678.693762] Subtest normal: SUCCESS (3.297s)
[679.078046] [121/133] (362s left) perf (gen12-group-exclusive-stream-sample-oa)
[679.268882] Starting subtest: gen12-group-exclusive-stream-sample-oa
[679.288844] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.020s)
[679.341328] [122/133] (362s left) sysfs_preempt_timeout (timeout)
[679.395657] Starting subtest: timeout
[679.398000] Starting dynamic subtest: vecs0
[689.076836] Dynamic subtest vecs0: SUCCESS (9.679s)
[689.089747] Starting dynamic subtest: ccs0
[690.339583] Dynamic subtest ccs0: SUCCESS (1.263s)
[690.357560] Starting dynamic subtest: vcs0
[700.084693] Dynamic subtest vcs0: SUCCESS (9.740s)
[700.104879] Starting dynamic subtest: bcs0
[701.328414] Dynamic subtest bcs0: SUCCESS (1.243s)
[701.341451] Starting dynamic subtest: rcs0
[702.522883] Dynamic subtest rcs0: SUCCESS (1.192s)
[702.535090] Starting dynamic subtest: vcs1
[712.056632] Dynamic subtest vcs1: SUCCESS (9.530s)
[712.059262] Subtest timeout: SUCCESS (32.661s)
[712.137677] [123/133] (329s left) syncobj_basic (bad-destroy)
[712.194947] Starting subtest: bad-destroy
[712.197224] Subtest bad-destroy: SUCCESS (0.000s)
[712.300509] [124/133] (329s left) gem_userptr_blits (relocations)
[712.376724] Starting subtest: relocations
[712.381323] Subtest relocations: SKIP (0.000s)
[712.504873] [125/133] (329s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[712.558530] Starting subtest: multi-wait-for-submit-available-submitted
[712.560860] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.000s)
[712.670970] [126/133] (329s left) kms_3d (basic)
[712.723470] Starting subtest: basic
[714.783095] Subtest basic: SUCCESS (2.062s)
[715.291328] [127/133] (326s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs)
[715.386894] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs
[715.389149] Starting dynamic subtest: pipe-A-eDP-1
[715.444964] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[715.456639] Starting dynamic subtest: pipe-B-eDP-1
[715.512709] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[715.524748] Starting dynamic subtest: pipe-C-eDP-1
[715.583902] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[715.595565] Starting dynamic subtest: pipe-D-eDP-1
[715.652575] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[715.657102] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.010s)
[717.654747] [128/133] (324s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[717.757283] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[717.761499] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[717.869070] [129/133] (323s left) gem_wait (write-wait)
[717.938308] Starting subtest: write-wait
[717.940548] Starting dynamic subtest: all-engines
[719.062804] Dynamic subtest all-engines: SUCCESS (1.124s)
[719.086435] Starting dynamic subtest: rcs0
[720.126673] Dynamic subtest rcs0: SUCCESS (1.061s)
[720.147267] Starting dynamic subtest: bcs0
[721.188536] Dynamic subtest bcs0: SUCCESS (1.060s)
[721.208953] Starting dynamic subtest: vcs0
[722.246247] Dynamic subtest vcs0: SUCCESS (1.056s)
[722.264114] Starting dynamic subtest: vcs1
[723.299214] Dynamic subtest vcs1: SUCCESS (1.051s)
[723.317969] Starting dynamic subtest: vecs0
[724.352892] Dynamic subtest vecs0: SUCCESS (1.051s)
[724.370634] Starting dynamic subtest: ccs0
[725.409547] Dynamic subtest ccs0: SUCCESS (1.055s)
[725.412158] Subtest write-wait: SUCCESS (7.473s)
[725.613159] [130/133] (316s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[725.706938] Starting subtest: plane-upscale-20x20-with-rotation
[725.709213] Starting dynamic subtest: pipe-A
[725.931584] Dynamic subtest pipe-A: SUCCESS (0.227s)
[725.942948] Starting dynamic subtest: pipe-B
[727.187075] Dynamic subtest pipe-B: SUCCESS (1.254s)
[727.198248] Starting dynamic subtest: pipe-C
[728.492936] Dynamic subtest pipe-C: SUCCESS (1.305s)
[728.505124] Starting dynamic subtest: pipe-D
[729.790487] Dynamic subtest pipe-D: SUCCESS (1.295s)
[729.792893] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.087s)
[730.957387] [131/133] (310s left) gem_mmap_wc (invalid-flags)
[731.028646] Subtest invalid-flags: SKIP (0.000s)
[731.090549] [132/133] (310s left) kms_cursor_crc (cursor-sliding-128x128)
[731.306730] Starting subtest: cursor-sliding-128x128
[731.313873] Starting dynamic subtest: pipe-A-eDP-1
[734.553447] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.237s)
[734.589123] Starting dynamic subtest: pipe-D-eDP-1
[738.418455] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.843s)
[738.421214] Subtest cursor-sliding-128x128: SUCCESS (7.110s)
[739.243706] [133/133] (302s left) i915_query (hwconfig_table)
[739.302610] Starting subtest: hwconfig_table
[739.606391] Subtest hwconfig_table: SUCCESS (0.001s)
[739.644965] Closing watchdogs
results: parsing output: 0/ for test: kms_big_fb
results: parsing output: 1/ for test: gem_mmap_gtt
results: parsing output: 2/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_flip
results: parsing output: 5/ for test: kms_atomic_transition
results: parsing output: 6/ for test: gem_busy
results: parsing output: 7/ for test: kms_vblank
results: parsing output: 8/ for test: syncobj_timeline
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_atomic
results: parsing output: 11/ for test: gem_mmap
results: parsing output: 12/ for test: kms_flip
results: parsing output: 13/ for test: kms_cursor_legacy
results: parsing output: 14/ for test: kms_content_protection
results: parsing output: 15/ for test: gem_render_copy
results: parsing output: 16/ for test: kms_psr2_sf
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_chamelium_hpd
results: parsing output: 19/ for test: syncobj_wait
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: vgem_basic
results: parsing output: 22/ for test: i915_drm_fdinfo
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: gem_exec_schedule
results: parsing output: 25/ for test: gem_ctx_engines
results: parsing output: 26/ for test: kms_addfb_basic
results: parsing output: 27/ for test: gem_exec_params
results: parsing output: 28/ for test: api_intel_bb
results: parsing output: 29/ for test: kms_invalid_mode
results: parsing output: 30/ for test: gem_workarounds
results: parsing output: 31/ for test: gem_readwrite
results: parsing output: 32/ for test: prime_busy
results: parsing output: 33/ for test: gem_ctx_persistence
results: parsing output: 34/ for test: gem_mmap_gtt
results: parsing output: 35/ for test: kms_rotation_crc
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_exec_suspend
results: parsing output: 38/ for test: kms_cursor_crc
results: parsing output: 39/ for test: perf_pmu
results: parsing output: 40/ for test: gem_exec_flush
results: parsing output: 41/ for test: kms_busy
results: parsing output: 42/ for test: gem_exec_whisper
results: parsing output: 43/ for test: kms_psr2_sf
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_flip
results: parsing output: 47/ for test: kms_plane_multiple
results: parsing output: 48/ for test: gem_render_copy
results: parsing output: 49/ for test: kms_prop_blob
results: parsing output: 50/ for test: api_intel_bb
results: parsing output: 51/ for test: gem_exec_fence
results: parsing output: 52/ for test: kms_rotation_crc
results: parsing output: 53/ for test: gem_ctx_param
results: parsing output: 54/ for test: kms_universal_plane
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: i915_pm_rpm
results: parsing output: 58/ for test: kms_cursor_legacy
results: parsing output: 59/ for test: i915_module_load
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: gem_sync
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: gem_ctx_bad_destroy
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_pipe_crc_basic
results: parsing output: 68/ for test: kms_cursor_crc
results: parsing output: 69/ for test: gem_exec_balancer
results: parsing output: 70/ for test: syncobj_timeline
results: parsing output: 71/ for test: kms_plane
results: parsing output: 72/ for test: kms_plane
results: parsing output: 73/ for test: kms_ccs
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_pipe_b_c_ivb
results: parsing output: 76/ for test: kms_psr
results: parsing output: 77/ for test: kms_chamelium_color
results: parsing output: 78/ for test: syncobj_wait
results: parsing output: 79/ for test: gem_spin_batch
results: parsing output: 80/ for test: kms_cursor_legacy
results: parsing output: 81/ for test: gem_set_tiling_vs_pwrite
results: parsing output: 82/ for test: gem_mmap_gtt
results: parsing output: 83/ for test: gem_softpin
results: parsing output: 84/ for test: kms_feature_discovery
results: parsing output: 85/ for test: kms_flip_scaled_crc
results: parsing output: 86/ for test: kms_color_pipeline
results: parsing output: 87/ for test: gem_mmap_wc
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: gem_exec_fence
results: parsing output: 90/ for test: kms_lease
results: parsing output: 91/ for test: kms_pm_dc
results: parsing output: 92/ for test: gem_exec_balancer
results: parsing output: 93/ for test: kms_psr
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: kms_fbcon_fbt
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: gen9_exec_parse
results: parsing output: 99/ for test: kms_psr
results: parsing output: 100/ for test: core_setmaster
results: parsing output: 101/ for test: kms_pm_rpm
results: parsing output: 102/ for test: perf_pmu
results: parsing output: 103/ for test: gem_render_copy
results: parsing output: 104/ for test: gem_userptr_blits
results: parsing output: 105/ for test: kms_ccs
results: parsing output: 106/ for test: kms_flip_scaled_crc
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: syncobj_timeline
results: parsing output: 109/ for test: gem_exec_schedule
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: syncobj_wait
results: parsing output: 112/ for test: gem_exec_whisper
results: parsing output: 113/ for test: kms_flip_scaled_crc
results: parsing output: 114/ for test: gem_render_copy_redux
results: parsing output: 115/ for test: gem_exec_alignment
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_chamelium_frames
results: parsing output: 119/ for test: gem_linear_blits
results: parsing output: 120/ for test: perf
results: parsing output: 121/ for test: sysfs_preempt_timeout
results: parsing output: 122/ for test: syncobj_basic
results: parsing output: 123/ for test: gem_userptr_blits
results: parsing output: 124/ for test: syncobj_timeline
results: parsing output: 125/ for test: kms_3d
results: parsing output: 126/ for test: kms_ccs
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: gem_wait
results: parsing output: 129/ for test: kms_plane_scaling
results: parsing output: 130/ for test: gem_mmap_wc
results: parsing output: 131/ for test: kms_cursor_crc
results: parsing output: 132/ for test: i915_query
Done.