[57.981969] Initializing watchdogs
[57.982210]   /dev/watchdog0
[57.997474] [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.001866] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.004462] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.007842] [001/131] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[58.138618] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[58.142713] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[58.261471] [002/131] (960s left) prime_vgem (sync)
[58.351571] Starting subtest: sync
[58.353478] Starting dynamic subtest: rcs0
[58.407835] Dynamic subtest rcs0: SUCCESS (0.057s)
[58.418243] Starting dynamic subtest: bcs0
[58.481498] Dynamic subtest bcs0: SUCCESS (0.073s)
[58.488321] Starting dynamic subtest: vcs0
[58.528225] Dynamic subtest vcs0: SUCCESS (0.046s)
[58.534951] Starting dynamic subtest: vcs1
[58.573647] Dynamic subtest vcs1: SUCCESS (0.045s)
[58.580594] Starting dynamic subtest: vecs0
[58.620341] Dynamic subtest vecs0: SUCCESS (0.046s)
[58.627262] Starting dynamic subtest: ccs0
[58.667299] Dynamic subtest ccs0: SUCCESS (0.046s)
[58.669623] Subtest sync: SUCCESS (0.316s)
[58.830096] [FACT prime_vgem (sync)] new: kernel.kmod_is_loaded.vgem: true
[58.832749] [003/131] (959s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[58.933090] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[58.936872] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[59.089048] [004/131] (959s left) i915_suspend (fence-restore-tiled2untiled)
[59.143272] Starting subtest: fence-restore-tiled2untiled
[59.147327] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[59.276058] [005/131] (959s left) kms_atomic_transition (plane-all-transition)
[59.381522] Starting subtest: plane-all-transition
[59.383497] Starting dynamic subtest: pipe-A-eDP-1
[61.937854] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.545s)
[62.250803] Starting dynamic subtest: pipe-B-eDP-1
[65.527193] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.272s)
[65.838953] Subtest plane-all-transition: SUCCESS (6.431s)
[66.683539] [006/131] (952s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[66.777163] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[66.883065] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.105s)
[67.053577] [007/131] (951s left) kms_color (ctm-negative)
[67.287475] Starting subtest: ctm-negative
[67.289944] Starting dynamic subtest: pipe-A-eDP-1
[68.031432] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.744s)
[68.038841] Starting dynamic subtest: pipe-B-eDP-1
[69.484194] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.450s)
[69.492845] Starting dynamic subtest: pipe-C-eDP-1
[70.862998] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.377s)
[70.871522] Starting dynamic subtest: pipe-D-eDP-1
[72.198669] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.332s)
[72.201046] Subtest ctm-negative: SUCCESS (4.904s)
[73.033818] [008/131] (945s left) syncobj_timeline (wait-for-submit-snapshot)
[73.105862] Starting subtest: wait-for-submit-snapshot
[73.186397] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[73.285677] [009/131] (945s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[73.392056] Starting subtest: fbcpsr-slowdraw
[98.642602] Subtest fbcpsr-slowdraw: SUCCESS (25.239s)
[98.800298] [010/131] (920s left) kms_joiner (basic-max-non-joiner)
[98.905328] Starting subtest: basic-max-non-joiner
[98.909777] Subtest basic-max-non-joiner: SKIP (0.000s)
[98.992971] [011/131] (920s left) kms_psr (pr-cursor-mmap-cpu)
[99.114053] Starting subtest: pr-cursor-mmap-cpu
[99.118609] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[99.209941] [012/131] (919s left) vgem_basic (create)
[99.261517] Starting subtest: create
[99.263698] Subtest create: SUCCESS (0.000s)
[99.344423] [013/131] (919s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[99.449077] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[99.452545] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[99.594966] [014/131] (919s left) kms_ccs (crc-primary-rotation-180-4-tiled-lnl-ccs)
[99.681976] Starting subtest: crc-primary-rotation-180-4-tiled-lnl-ccs
[99.686045] Subtest crc-primary-rotation-180-4-tiled-lnl-ccs: SKIP (0.000s)
[100.801325] [015/131] (918s left) kms_selftest (drm_dp_mst_helper)
[100.843694] Starting subtest: drm_dp_mst_helper
[100.851496] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[100.995892] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.145s)
[101.008048] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[101.150781] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.156s)
[101.159573] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[101.295655] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.144s)
[101.297975] Subtest drm_dp_mst_helper: SUCCESS (0.455s)
[101.463817] [016/131] (917s left) kms_lease (lease-uevent)
[101.576354] Starting subtest: lease-uevent
[102.586142] Subtest lease-uevent: SUCCESS (1.011s)
[102.703641] [017/131] (916s left) gem_exec_fence (invalid-timeline-fence-array)
[103.239342] Starting subtest: invalid-timeline-fence-array
[103.244811] Subtest invalid-timeline-fence-array: SUCCESS (0.007s)
[105.014010] [018/131] (914s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[105.124674] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[105.129207] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[105.262263] [019/131] (914s left) kms_feature_discovery (display-4x)
[105.371901] Starting subtest: display-4x
[105.376358] Subtest display-4x: SKIP (0.000s)
[105.467832] [020/131] (913s left) perf (oa-formats)
[105.612636] Starting subtest: oa-formats
[105.614612] Starting dynamic subtest: 0-rcs0
[105.628377] Dynamic subtest 0-rcs0: SUCCESS (0.017s)
[105.637071] Starting dynamic subtest: 1-vecs0
[105.650635] Dynamic subtest 1-vecs0: SUCCESS (0.022s)
[105.653030] Subtest oa-formats: SUCCESS (0.040s)
[105.698454] [021/131] (913s left) api_intel_allocator (execbuf-with-allocator)
[105.765307] Starting subtest: execbuf-with-allocator
[105.769640] Subtest execbuf-with-allocator: SUCCESS (0.007s)
[105.947436] [022/131] (913s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[106.053215] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[113.485354] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.433s)
[113.648456] [023/131] (905s left) kms_cursor_edge_walk (256x256-left-edge)
[113.758035] Starting subtest: 256x256-left-edge
[113.760327] Starting dynamic subtest: pipe-A-eDP-1
[117.166411] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.408s)
[117.174859] Starting dynamic subtest: pipe-D-eDP-1
[120.301216] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.134s)
[120.303552] Subtest 256x256-left-edge: SUCCESS (6.545s)
[121.137141] [024/131] (898s left) gem_exec_whisper (basic-fds-priority)
[121.202458] Starting subtest: basic-fds-priority
[145.291047] Subtest basic-fds-priority: SUCCESS (24.082s)
[145.502156] [025/131] (874s left) kms_sequence (get-forked-busy)
[145.607841] Starting subtest: get-forked-busy
[145.610272] Starting dynamic subtest: pipe-A-eDP-1
[147.543210] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.934s)
[147.552431] Starting dynamic subtest: pipe-B-eDP-1
[150.118541] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.576s)
[150.128078] Starting dynamic subtest: pipe-C-eDP-1
[152.726342] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.605s)
[152.736076] Starting dynamic subtest: pipe-D-eDP-1
[155.261603] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.537s)
[155.264031] Subtest get-forked-busy: SUCCESS (9.657s)
[156.170654] [026/131] (863s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[156.280162] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[156.282551] Starting dynamic subtest: pipe-A-default-mode
[156.569665] Dynamic subtest pipe-A-default-mode: SKIP (0.289s)
[156.574078] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.291s)
[157.400236] [027/131] (862s left) kms_draw_crc (draw-method-mmap-wc)
[157.499395] Starting subtest: draw-method-mmap-wc
[157.501645] Starting dynamic subtest: xrgb8888-untiled
[157.731599] Dynamic subtest xrgb8888-untiled: SUCCESS (0.234s)
[157.740840] Starting dynamic subtest: rgb565-untiled
[157.954027] Dynamic subtest rgb565-untiled: SUCCESS (0.221s)
[157.962296] Starting dynamic subtest: xrgb2101010-untiled
[158.175861] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s)
[158.184204] Starting dynamic subtest: xbgr16161616f-untiled
[158.431498] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.253s)
[158.439487] Starting dynamic subtest: xrgb8888-xtiled
[158.575627] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.143s)
[158.583525] Starting dynamic subtest: rgb565-xtiled
[158.720029] Dynamic subtest rgb565-xtiled: SUCCESS (0.144s)
[158.727720] Starting dynamic subtest: xrgb2101010-xtiled
[158.853236] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.133s)
[158.861056] Starting dynamic subtest: xbgr16161616f-xtiled
[158.975742] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.122s)
[158.985694] Starting dynamic subtest: xrgb8888-4tiled
[159.131331] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.153s)
[159.138675] Starting dynamic subtest: rgb565-4tiled
[159.286747] Dynamic subtest rgb565-4tiled: SUCCESS (0.154s)
[159.296562] Starting dynamic subtest: xrgb2101010-4tiled
[159.420241] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.131s)
[159.427758] Starting dynamic subtest: xbgr16161616f-4tiled
[159.598020] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.177s)
[159.599918] Subtest draw-method-mmap-wc: SUCCESS (2.101s)
[159.727409] [028/131] (860s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[159.832338] Starting subtest: plane-upscale-factor-0-25-with-rotation
[159.834179] Starting dynamic subtest: pipe-A
[160.057745] Dynamic subtest pipe-A: SUCCESS (0.227s)
[160.071636] Starting dynamic subtest: pipe-B
[161.365485] Dynamic subtest pipe-B: SUCCESS (1.305s)
[161.376102] Starting dynamic subtest: pipe-C
[162.695361] Dynamic subtest pipe-C: SUCCESS (1.329s)
[162.711050] Starting dynamic subtest: pipe-D
[164.027149] Dynamic subtest pipe-D: SUCCESS (1.330s)
[164.029499] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.198s)
[165.239094] [029/131] (854s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[165.327231] Starting subtest: primary-y-tiled-reflect-x-270
[165.331647] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[165.421085] [030/131] (854s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[165.519774] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[165.524238] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[165.649135] [031/131] (854s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[165.709949] Subtest writes-after-reads: SKIP (0.000s)
[165.780664] [032/131] (854s left) gem_mmap_gtt (isolation)
[165.841794] Subtest isolation: SKIP (0.000s)
[165.918160] [033/131] (854s left) gem_mmap_offset (pf-nonblock)
[165.977380] Starting subtest: pf-nonblock
[165.984840] Subtest pf-nonblock: SUCCESS (0.006s)
[166.091398] [034/131] (853s left) prime_self_import (basic-with_one_bo)
[166.126250] Starting subtest: basic-with_one_bo
[166.149173] Subtest basic-with_one_bo: SUCCESS (0.024s)
[166.281262] [035/131] (853s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[166.378720] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[166.382207] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[166.508776] [036/131] (853s left) syncobj_wait (single-wait-signaled)
[166.557123] Starting subtest: single-wait-signaled
[166.558771] Subtest single-wait-signaled: SUCCESS (0.000s)
[166.675102] [037/131] (853s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[171.703536] Starting subtest: pr-cursor-plane-update-sf
[171.707883] Subtest pr-cursor-plane-update-sf: SKIP (0.002s)
[172.570611] [038/131] (847s left) kms_cursor_crc (cursor-onscreen-256x256)
[172.812682] Starting subtest: cursor-onscreen-256x256
[172.817566] Starting dynamic subtest: pipe-A-eDP-1
[174.919323] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.101s)
[174.947506] Starting dynamic subtest: pipe-D-eDP-1
[177.760419] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.816s)
[177.762721] Subtest cursor-onscreen-256x256: SUCCESS (4.944s)
[178.644332] [039/131] (841s left) kms_vrr (flipline)
[178.734101] Starting subtest: flipline
[178.740131] Subtest flipline: SKIP (0.000s)
[178.833026] [040/131] (841s left) kms_chamelium_color (ctm-0-50)
[178.935321] Subtest ctm-0-50: SKIP (0.000s)
[178.979486] [041/131] (841s left) gem_mmap_wc (fault-concurrent)
[179.035590] Subtest fault-concurrent: SKIP (0.000s)
[179.102567] [042/131] (841s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[179.228573] Starting subtest: cursorA-vs-flipB-varying-size
[179.233089] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[179.397894] [043/131] (840s left) gem_exec_schedule (fairslice)
[179.464321] Starting subtest: fairslice
[179.466229] Starting dynamic subtest: rcs0
[181.478987] Dynamic subtest rcs0: SUCCESS (2.021s)
[181.487204] Starting dynamic subtest: bcs0
[183.498180] Dynamic subtest bcs0: SUCCESS (2.019s)
[183.507568] Starting dynamic subtest: vcs0
[185.524177] Dynamic subtest vcs0: SUCCESS (2.024s)
[185.534340] Starting dynamic subtest: vcs1
[187.544048] Dynamic subtest vcs1: SUCCESS (2.019s)
[187.552601] Starting dynamic subtest: vecs0
[189.563526] Dynamic subtest vecs0: SUCCESS (2.017s)
[189.572078] Starting dynamic subtest: ccs0
[191.581890] Dynamic subtest ccs0: SUCCESS (2.020s)
[191.583813] Subtest fairslice: SUCCESS (12.125s)
[191.912804] [044/131] (828s left) syncobj_wait (signal)
[191.975072] Starting subtest: signal
[191.977396] Subtest signal: SUCCESS (0.000s)
[192.114873] [045/131] (828s left) gem_exec_schedule (thriceslice)
[192.195858] Starting subtest: thriceslice
[192.197846] Starting dynamic subtest: rcs0
[192.247394] Dynamic subtest rcs0: SUCCESS (0.055s)
[192.258942] Starting dynamic subtest: bcs0
[192.286505] Dynamic subtest bcs0: SUCCESS (0.037s)
[192.299876] Starting dynamic subtest: vcs0
[192.345536] Dynamic subtest vcs0: SUCCESS (0.056s)
[192.359313] Starting dynamic subtest: vcs1
[192.402773] Dynamic subtest vcs1: SUCCESS (0.055s)
[192.413066] Starting dynamic subtest: vecs0
[192.457306] Dynamic subtest vecs0: SUCCESS (0.052s)
[192.470742] Starting dynamic subtest: ccs0
[192.522840] Dynamic subtest ccs0: SUCCESS (0.062s)
[192.525711] Subtest thriceslice: SUCCESS (0.333s)
[192.864516] [046/131] (827s left) gem_exec_balancer (hog)
[192.929893] Starting subtest: hog
[192.934330] Subtest hog: SKIP (0.000s)
[193.268621] [047/131] (827s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[193.367291] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[193.371839] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[193.501399] [048/131] (827s left) gem_partial_pwrite_pread (write)
[193.565383] Subtest write: SKIP (0.000s)
[193.634919] [049/131] (826s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[195.171542] Starting subtest: modeset-lpsp-stress-no-wait
[205.132367] Subtest modeset-lpsp-stress-no-wait: SUCCESS (9.959s)
[205.236409] [050/131] (815s left) kms_plane_multiple (tiling-4)
[205.326223] Starting subtest: tiling-4
[205.328545] Starting dynamic subtest: pipe-A-eDP-1
[209.133335] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.806s)
[209.142643] Starting dynamic subtest: pipe-B-eDP-1
[213.643691] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.509s)
[213.652217] Starting dynamic subtest: pipe-C-eDP-1
[217.966611] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.321s)
[217.974843] Starting dynamic subtest: pipe-D-eDP-1
[222.301631] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.335s)
[222.303994] Subtest tiling-4: SUCCESS (16.977s)
[223.141871] [051/131] (797s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[223.244042] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[223.246325] Starting dynamic subtest: pipe-A-eDP-1
[223.268949] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[223.279724] Starting dynamic subtest: pipe-B-eDP-1
[223.300863] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[223.308448] Starting dynamic subtest: pipe-C-eDP-1
[223.329779] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[223.337522] Starting dynamic subtest: pipe-D-eDP-1
[223.359019] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[223.363229] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[225.498556] [052/131] (795s left) kms_big_fb (linear-32bpp-rotate-270)
[225.605496] Starting subtest: linear-32bpp-rotate-270
[225.627378] Subtest linear-32bpp-rotate-270: SKIP (0.018s)
[225.786749] [053/131] (794s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[225.873588] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[225.875903] Starting dynamic subtest: pipe-A-default-mode
[227.026481] Dynamic subtest pipe-A-default-mode: SKIP (1.151s)
[227.030986] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.153s)
[227.232920] [054/131] (793s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[227.336748] Starting subtest: fbcpsr-indfb-scaledprimary
[233.117248] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (5.783s)
[233.266095] [055/131] (787s left) gem_exec_flush (basic-wb-ro-default)
[233.332078] Starting subtest: basic-wb-ro-default
[238.790066] Subtest basic-wb-ro-default: SUCCESS (5.459s)
[239.006313] [056/131] (781s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[239.114415] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[239.118737] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[239.244246] [057/131] (781s left) kms_flip (2x-blocking-wf_vblank)
[239.347209] Starting subtest: 2x-blocking-wf_vblank
[239.355403] Subtest 2x-blocking-wf_vblank: SKIP (0.011s)
[239.503719] [058/131] (781s left) core_setmaster (master-drop-set-root)
[239.594230] Starting subtest: master-drop-set-root
[239.603767] Subtest master-drop-set-root: SUCCESS (0.010s)
[239.649673] [059/131] (781s left) gem_partial_pwrite_pread (reads)
[239.714936] Subtest reads: SKIP (0.000s)
[239.816198] [060/131] (781s left) kms_pm_rpm (fences-dpms)
[242.040690] Starting subtest: fences-dpms
[242.045500] Subtest fences-dpms: SKIP (0.000s)
[242.423603] [061/131] (778s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[242.486846] Starting subtest: multi-wait-all-for-submit-signaled
[242.489577] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[242.613904] [062/131] (778s left) kms_chamelium_edid (dp-edid-resolution-list)
[242.991951] Subtest dp-edid-resolution-list: SKIP (0.000s)
[243.803242] [063/131] (777s left) gem_mmap_gtt (bad-object)
[243.874028] Subtest bad-object: SKIP (0.000s)
[243.944816] [064/131] (777s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[244.039039] Starting subtest: async-flip-with-page-flip-events-tiled
[244.431682] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[247.199411] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.766s)
[247.211190] Starting dynamic subtest: pipe-A-eDP-1-4
[249.374579] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.173s)
[249.386036] Starting dynamic subtest: pipe-A-eDP-1-4
[251.384626] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[251.396230] Starting dynamic subtest: pipe-A-eDP-1-x
[253.574764] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.189s)
[253.949767] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[256.732101] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.787s)
[256.743727] Starting dynamic subtest: pipe-B-eDP-1-4
[258.929539] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.196s)
[258.941045] Starting dynamic subtest: pipe-B-eDP-1-4
[260.939072] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[260.948083] Starting dynamic subtest: pipe-B-eDP-1-x
[263.129423] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[263.495711] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[266.262209] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.772s)
[266.276445] Starting dynamic subtest: pipe-C-eDP-1-4
[268.438036] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s)
[268.447532] Starting dynamic subtest: pipe-C-eDP-1-4
[270.448734] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[270.457761] Starting dynamic subtest: pipe-C-eDP-1-x
[272.627154] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s)
[272.999731] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[275.792211] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.800s)
[275.801312] Starting dynamic subtest: pipe-D-eDP-1-4
[277.967134] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.173s)
[277.977760] Starting dynamic subtest: pipe-D-eDP-1-4
[279.977735] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[279.987623] Starting dynamic subtest: pipe-D-eDP-1-x
[282.178790] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.200s)
[282.181528] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.139s)
[283.396820] [065/131] (737s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[283.502750] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[283.507123] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[283.642366] [066/131] (737s left) gem_exec_alignment (many)
[283.717071] Starting subtest: many
[307.177494] Subtest many: SUCCESS (23.460s)
[308.673114] [067/131] (712s left) kms_psr (psr-dpms)
[308.812790] Starting subtest: psr-dpms
[308.815201] Starting dynamic subtest: eDP-1
[311.796886] Dynamic subtest eDP-1: SUCCESS (2.983s)
[311.799200] Subtest psr-dpms: SUCCESS (2.984s)
[312.683115] [068/131] (708s left) gem_ctx_persistence (engines-mixed-process)
[312.746268] Starting subtest: engines-mixed-process
[312.748688] Starting dynamic subtest: rcs0
[313.899092] Dynamic subtest rcs0: SUCCESS (1.152s)
[313.910713] Starting dynamic subtest: bcs0
[315.960885] Dynamic subtest bcs0: SUCCESS (2.060s)
[315.972856] Starting dynamic subtest: vcs0
[317.871771] Dynamic subtest vcs0: SUCCESS (1.909s)
[317.883373] Starting dynamic subtest: vcs1
[319.903795] Dynamic subtest vcs1: SUCCESS (2.030s)
[319.914377] Starting dynamic subtest: vecs0
[321.895917] Dynamic subtest vecs0: SUCCESS (1.990s)
[321.907203] Starting dynamic subtest: ccs0
[323.955938] Dynamic subtest ccs0: SUCCESS (2.058s)
[323.958765] Subtest engines-mixed-process: SUCCESS (11.210s)
[324.062316] [069/131] (697s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[324.178413] Starting subtest: 4-tiled-32bpp-rotate-180
[325.769785] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.591s)
[325.923434] [070/131] (695s left) prime_vgem (coherency-gtt)
[326.009106] Starting subtest: coherency-gtt
[326.013127] Subtest coherency-gtt: SKIP (0.000s)
[326.153442] [071/131] (695s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[326.377791] Starting subtest: cursor-rapid-movement-128x42
[326.425503] Subtest cursor-rapid-movement-128x42: SKIP (0.043s)
[326.679227] [072/131] (694s left) gem_exec_balancer (waits)
[326.735513] Starting subtest: waits
[333.247048] Subtest waits: SUCCESS (6.508s)
[333.588949] [073/131] (687s left) sysfs_preempt_timeout (invalid)
[333.642117] Starting subtest: invalid
[333.644396] Starting dynamic subtest: vecs0
[333.646968] Dynamic subtest vecs0: SUCCESS (0.000s)
[333.656963] Starting dynamic subtest: ccs0
[333.659078] Dynamic subtest ccs0: SUCCESS (0.000s)
[333.668337] Starting dynamic subtest: vcs0
[333.670544] Dynamic subtest vcs0: SUCCESS (0.000s)
[333.679816] Starting dynamic subtest: bcs0
[333.681753] Dynamic subtest bcs0: SUCCESS (0.000s)
[333.690289] Starting dynamic subtest: rcs0
[333.692154] Dynamic subtest rcs0: SUCCESS (0.000s)
[333.700483] Starting dynamic subtest: vcs1
[333.702377] Dynamic subtest vcs1: SUCCESS (0.000s)
[333.704302] Subtest invalid: SUCCESS (0.006s)
[333.749394] [074/131] (687s left) gem_spin_batch (resubmit-all)
[333.816938] Starting subtest: resubmit-all
[333.819131] Starting dynamic subtest: rcs0
[333.832513] Dynamic subtest rcs0: SUCCESS (0.018s)
[333.844179] Starting dynamic subtest: bcs0
[333.846390] Dynamic subtest bcs0: SUCCESS (0.003s)
[333.855301] Starting dynamic subtest: vcs0
[333.857153] Dynamic subtest vcs0: SUCCESS (0.002s)
[333.865709] Starting dynamic subtest: vcs1
[333.867592] Dynamic subtest vcs1: SUCCESS (0.002s)
[333.876665] Starting dynamic subtest: vecs0
[333.878823] Dynamic subtest vecs0: SUCCESS (0.003s)
[333.889913] Starting dynamic subtest: ccs0
[333.891835] Dynamic subtest ccs0: SUCCESS (0.002s)
[333.893975] Subtest resubmit-all: SUCCESS (0.034s)
[334.128510] [075/131] (687s left) gem_exec_gttfill (basic)
[334.197740] Starting subtest: basic
[337.342834] Subtest basic: SUCCESS (3.144s)
[337.558469] [076/131] (684s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[337.713411] Starting subtest: yf-tiled-16bpp-rotate-270
[337.717320] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[337.843817] [077/131] (683s left) gem_ctx_persistence (file)
[337.901690] Starting subtest: file
[338.042231] Subtest file: SUCCESS (0.140s)
[338.190106] [078/131] (683s left) gem_fenced_exec_thrash (too-many-fences)
[338.251342] Subtest too-many-fences: SKIP (0.000s)
[338.322288] [079/131] (683s left) api_intel_bb (misplaced-blitter)
[338.383663] Starting subtest: misplaced-blitter
[338.389728] Subtest misplaced-blitter: SUCCESS (0.009s)
[338.554392] [080/131] (683s left) gen7_exec_parse (basic-rejected)
[338.617790] Subtest basic-rejected: SKIP (0.000s)
[338.696635] [081/131] (683s left) gem_pxp (hw-rejects-pxp-context)
[338.816913] Starting subtest: hw-rejects-pxp-context
[338.820631] Subtest hw-rejects-pxp-context: SKIP (0.000s)
[338.948189] [082/131] (683s left) gem_softpin (evict-active-interruptible)
[339.011038] Starting subtest: evict-active-interruptible
[339.015968] Subtest evict-active-interruptible: SUCCESS (0.005s)
[339.196248] [083/131] (682s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[339.292271] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[339.295583] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[339.435315] [084/131] (682s left) syncobj_timeline (invalid-signal-zero-handles)
[339.493115] Starting subtest: invalid-signal-zero-handles
[339.494913] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[339.648493] [085/131] (682s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[339.757315] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[339.760800] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[339.878404] [086/131] (682s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[339.984365] Starting subtest: x-tiled-8bpp-rotate-270
[340.005611] Subtest x-tiled-8bpp-rotate-270: SKIP (0.021s)
[340.132878] [087/131] (682s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[340.229836] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[340.233542] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[340.373372] [088/131] (681s left) i915_pm_freq_api (freq-reset)
[340.441114] Starting subtest: freq-reset
[340.443118] Starting dynamic subtest: gt0
[340.634413] Dynamic subtest gt0: SUCCESS (0.192s)
[340.644976] Starting dynamic subtest: gt1
[340.802066] Dynamic subtest gt1: SUCCESS (0.165s)
[340.804782] Subtest freq-reset: SUCCESS (0.359s)
[340.901459] [089/131] (681s left) gem_unfence_active_buffers
[341.073355] [090/131] (681s left) syncobj_timeline (reset-unsignaled)
[341.127494] Starting subtest: reset-unsignaled
[341.129817] Subtest reset-unsignaled: SUCCESS (0.000s)
[341.247735] [091/131] (681s left) gem_render_copy (y-tiled)
[341.304816] Starting subtest: y-tiled
[341.309384] Subtest y-tiled: SKIP (0.000s)
[341.510131] [092/131] (680s left) gem_wait (busy)
[341.565944] Starting subtest: busy
[341.568373] Starting dynamic subtest: all-engines
[342.935455] Dynamic subtest all-engines: SUCCESS (1.367s)
[342.947773] Starting dynamic subtest: rcs0
[343.478841] Dynamic subtest rcs0: SUCCESS (0.543s)
[343.490631] Starting dynamic subtest: bcs0
[344.020180] Dynamic subtest bcs0: SUCCESS (0.540s)
[344.031243] Starting dynamic subtest: vcs0
[345.943602] Dynamic subtest vcs0: SUCCESS (1.921s)
[345.955765] Starting dynamic subtest: vcs1
[347.927231] Dynamic subtest vcs1: SUCCESS (1.981s)
[347.939317] Starting dynamic subtest: vecs0
[349.911106] Dynamic subtest vecs0: SUCCESS (1.981s)
[349.922385] Starting dynamic subtest: ccs0
[350.453896] Dynamic subtest ccs0: SUCCESS (0.541s)
[350.456650] Subtest busy: SUCCESS (8.887s)
[350.671303] [093/131] (671s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[350.783197] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[350.787089] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[350.900827] [094/131] (671s left) i915_drm_fdinfo (busy-check-all)
[350.944952] Starting subtest: busy-check-all
[350.947236] Starting dynamic subtest: rcs0
[350.951747] Dynamic subtest rcs0: SKIP (0.004s)
[350.966611] Starting dynamic subtest: bcs0
[350.970971] Dynamic subtest bcs0: SKIP (0.000s)
[350.979975] Starting dynamic subtest: vcs0
[350.983959] Dynamic subtest vcs0: SKIP (0.000s)
[350.993130] Starting dynamic subtest: vcs1
[350.997105] Dynamic subtest vcs1: SKIP (0.000s)
[351.005470] Starting dynamic subtest: vecs0
[351.009399] Dynamic subtest vecs0: SKIP (0.000s)
[351.017885] Starting dynamic subtest: ccs0
[351.021962] Dynamic subtest ccs0: SKIP (0.000s)
[351.026058] Subtest busy-check-all: SKIP (0.009s)
[351.062421] [095/131] (671s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[351.202577] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[358.235369] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (7.032s)
[358.419466] [096/131] (664s left) gem_gtt_cpu_tlb
[358.551172] [097/131] (664s left) gem_eio (wait-wedge-10ms)
[358.756571] Starting subtest: wait-wedge-10ms
[359.959674] Subtest wait-wedge-10ms: SUCCESS (1.202s)
[360.102094] [098/131] (662s left) core_setmaster_vs_auth
[360.309378] [099/131] (662s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[360.425532] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[369.499178] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (9.074s)
[370.320418] [100/131] (652s left) kms_flip (2x-absolute-wf_vblank)
[370.427197] Starting subtest: 2x-absolute-wf_vblank
[370.436429] Subtest 2x-absolute-wf_vblank: SKIP (0.011s)
[370.541833] [101/131] (652s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[370.643858] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[370.646283] Starting dynamic subtest: pipe-A-eDP-1
[370.666706] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.023s)
[370.681833] Starting dynamic subtest: pipe-B-eDP-1
[370.702078] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.023s)
[370.717024] Starting dynamic subtest: pipe-C-eDP-1
[370.738138] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.023s)
[370.749120] Starting dynamic subtest: pipe-D-eDP-1
[370.769523] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s)
[370.771712] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.098s)
[372.927345] [102/131] (649s left) i915_pm_rps (engine-order)
[372.999577] Starting subtest: engine-order
[378.160630] Subtest engine-order: SUCCESS (5.160s)
[378.328321] [103/131] (644s left) kms_rotation_crc (bad-pixel-format)
[378.433979] Starting subtest: bad-pixel-format
[378.438351] Subtest bad-pixel-format: SKIP (0.001s)
[378.532190] [104/131] (644s left) perf_pmu (module-unload)
[378.627955] Starting subtest: module-unload
[386.487657] Subtest module-unload: FAIL (7.755s)
[386.523210] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[386.523969] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[386.527469] [105/131] (636s left) gem_render_copy (y-tiled-to-vebox-linear)
[388.084752] Starting subtest: y-tiled-to-vebox-linear
[388.089169] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[388.237407] [FACT gem_render_copy (y-tiled-to-vebox-linear)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[388.238595] [FACT gem_render_copy (y-tiled-to-vebox-linear)] new: kernel.kmod_is_loaded.i915: true
[388.242200] [106/131] (634s left) gem_cs_tlb (engines)
[388.317073] Starting subtest: engines
[388.319355] Starting dynamic subtest: rcs0
[390.478348] Dynamic subtest rcs0: SUCCESS (2.156s)
[390.487444] Starting dynamic subtest: bcs0
[392.630956] Dynamic subtest bcs0: SUCCESS (2.151s)
[392.640771] Starting dynamic subtest: vcs0
[394.783941] Dynamic subtest vcs0: SUCCESS (2.153s)
[394.792607] Starting dynamic subtest: vcs1
[396.937719] Dynamic subtest vcs1: SUCCESS (2.152s)
[396.946610] Starting dynamic subtest: vecs0
[399.090959] Dynamic subtest vecs0: SUCCESS (2.153s)
[399.099094] Starting dynamic subtest: ccs0
[401.243093] Dynamic subtest ccs0: SUCCESS (2.151s)
[401.245469] Subtest engines: SUCCESS (12.922s)
[401.426130] [107/131] (621s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[401.537158] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[401.541364] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[401.674750] [108/131] (621s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[401.726587] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[401.728725] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[401.853318] [109/131] (621s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[401.952453] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[409.298312] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.347s)
[409.460655] [110/131] (613s left) kms_rotation_crc (exhaust-fences)
[409.566323] Starting subtest: exhaust-fences
[409.570760] Subtest exhaust-fences: SKIP (0.000s)
[409.664819] [111/131] (613s left) kms_atomic (plane-overlay-legacy)
[409.765931] Starting subtest: plane-overlay-legacy
[409.768313] Starting dynamic subtest: pipe-A-eDP-1
[410.175803] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.410s)
[410.178147] Subtest plane-overlay-legacy: SUCCESS (0.412s)
[410.995879] [112/131] (612s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[411.096366] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[411.098476] Starting dynamic subtest: pipe-A-eDP-1
[411.369335] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.243s)
[411.380062] Starting dynamic subtest: pipe-B-eDP-1
[412.649867] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.280s)
[412.660228] Starting dynamic subtest: pipe-C-eDP-1
[413.861971] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.207s)
[413.871562] Starting dynamic subtest: pipe-D-eDP-1
[415.078198] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.220s)
[415.080094] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (3.955s)
[416.230973] [113/131] (607s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[416.327806] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[416.332256] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[416.435960] [114/131] (606s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[416.831056] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[417.625777] [115/131] (605s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[417.728907] Starting subtest: fbc-psr2-sprite-plane-onoff
[417.731174] Starting dynamic subtest: eDP-1
[417.735290] Dynamic subtest eDP-1: SKIP (0.000s)
[417.739643] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s)
[417.823991] [116/131] (605s left) kms_psr (pr-primary-page-flip)
[417.919175] Starting subtest: pr-primary-page-flip
[417.923397] Subtest pr-primary-page-flip: SKIP (0.000s)
[418.014549] [117/131] (605s left) gem_exec_reloc (basic-wc-gtt)
[418.075678] Subtest basic-wc-gtt: SKIP (0.000s)
[418.165368] [118/131] (605s left) kms_plane_scaling (intel-max-src-size)
[418.265149] Starting subtest: intel-max-src-size
[418.271587] Subtest intel-max-src-size: SKIP (0.000s)
[418.397714] [119/131] (605s left) gem_eio (in-flight-1us)
[418.638452] Starting subtest: in-flight-1us
[427.030879] Subtest in-flight-1us: SUCCESS (8.392s)
[427.247414] [120/131] (596s left) kms_psr (fbc-pr-dpms)
[427.343215] Starting subtest: fbc-pr-dpms
[427.347247] Subtest fbc-pr-dpms: SKIP (0.000s)
[427.440594] [121/131] (596s left) gem_exec_schedule (noreorder)
[427.630046] Starting subtest: noreorder
[427.632772] Starting dynamic subtest: rcs0
[427.705457] Dynamic subtest rcs0: SUCCESS (0.076s)
[427.722409] Starting dynamic subtest: vcs0
[428.870701] Dynamic subtest vcs0: SUCCESS (1.162s)
[428.882499] Starting dynamic subtest: vcs1
[430.972267] Dynamic subtest vcs1: SUCCESS (2.100s)
[430.983744] Starting dynamic subtest: vecs0
[432.941544] Dynamic subtest vecs0: SUCCESS (1.967s)
[432.953449] Starting dynamic subtest: ccs0
[433.015062] Dynamic subtest ccs0: SUCCESS (0.073s)
[433.017766] Subtest noreorder: SUCCESS (5.387s)
[433.229342] [122/131] (590s left) gem_ccs (block-multicopy-inplace)
[433.280377] Starting subtest: block-multicopy-inplace
[433.285071] Subtest block-multicopy-inplace: SKIP (0.000s)
[433.427229] [123/131] (590s left) gem_exec_whisper (basic-queues-priority)
[433.493525] Starting subtest: basic-queues-priority
[457.045090] Subtest basic-queues-priority: SUCCESS (23.548s)
[457.249464] [124/131] (566s left) sw_sync (sync_merge)
[457.284878] Starting subtest: sync_merge
[457.287542] Subtest sync_merge: SUCCESS (0.000s)
[457.361164] [125/131] (566s left) kms_legacy_colorkey (invalid-plane)
[457.459168] Starting subtest: invalid-plane
[457.461401] Starting dynamic subtest: zero-id
[457.463531] Dynamic subtest zero-id: SUCCESS (0.000s)
[457.472475] Starting dynamic subtest: outrange-id
[457.474309] Dynamic subtest outrange-id: SUCCESS (0.000s)
[457.476210] Subtest invalid-plane: SUCCESS (0.001s)
[457.554708] [126/131] (566s left) kms_dirtyfb (default-dirtyfb-ioctl)
[457.643955] Starting subtest: default-dirtyfb-ioctl
[457.645814] Starting dynamic subtest: A-eDP-1
[459.271556] Dynamic subtest A-eDP-1: SUCCESS (1.626s)
[459.273574] Subtest default-dirtyfb-ioctl: SUCCESS (1.627s)
[460.095122] [127/131] (563s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[465.085600] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[465.090072] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.003s)
[465.948576] [128/131] (557s left) prime_mmap (test_map_unmap)
[466.004306] Starting subtest: test_map_unmap
[466.006272] Starting dynamic subtest: test_map_unmap-smem
[466.033984] Dynamic subtest test_map_unmap-smem: SUCCESS (0.032s)
[466.036455] Subtest test_map_unmap: SUCCESS (0.032s)
[466.162804] [129/131] (557s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[466.221794] Starting subtest: etime-multi-wait-all-for-submit-submitted
[466.322206] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.102s)
[466.425815] [130/131] (557s left) gem_userptr_blits (process-exit)
[466.493264] Starting subtest: process-exit
[466.500049] Subtest process-exit: SUCCESS (0.010s)
[466.666139] [131/131] (557s left) perf_pmu (busy-idle-check-all)
[466.708988] Starting subtest: busy-idle-check-all
[466.710969] Starting dynamic subtest: rcs0
[467.384810] Dynamic subtest rcs0: SUCCESS (0.677s)
[467.397186] Starting dynamic subtest: bcs0
[468.036579] Dynamic subtest bcs0: SUCCESS (0.649s)
[468.048656] Starting dynamic subtest: vcs0
[469.913084] Dynamic subtest vcs0: SUCCESS (1.872s)
[469.924719] Starting dynamic subtest: vcs1
[471.895976] Dynamic subtest vcs1: SUCCESS (1.980s)
[471.907221] Starting dynamic subtest: vecs0
[473.880145] Dynamic subtest vecs0: SUCCESS (1.981s)
[473.892542] Starting dynamic subtest: ccs0
[474.538085] Dynamic subtest ccs0: SUCCESS (0.656s)
[474.540728] Subtest busy-idle-check-all: SUCCESS (7.832s)
[474.655622] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: prime_vgem
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: i915_suspend
results: parsing output: 4/ for test: kms_atomic_transition
results: parsing output: 5/ for test: syncobj_wait
results: parsing output: 6/ for test: kms_color
results: parsing output: 7/ for test: syncobj_timeline
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_joiner
results: parsing output: 10/ for test: kms_psr
results: parsing output: 11/ for test: vgem_basic
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_ccs
results: parsing output: 14/ for test: kms_selftest
results: parsing output: 15/ for test: kms_lease
results: parsing output: 16/ for test: gem_exec_fence
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_feature_discovery
results: parsing output: 19/ for test: perf
results: parsing output: 20/ for test: api_intel_allocator
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_cursor_edge_walk
results: parsing output: 23/ for test: gem_exec_whisper
results: parsing output: 24/ for test: kms_sequence
results: parsing output: 25/ for test: kms_flip_scaled_crc
results: parsing output: 26/ for test: kms_draw_crc
results: parsing output: 27/ for test: kms_plane_scaling
results: parsing output: 28/ for test: kms_rotation_crc
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 31/ for test: gem_mmap_gtt
results: parsing output: 32/ for test: gem_mmap_offset
results: parsing output: 33/ for test: prime_self_import
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: syncobj_wait
results: parsing output: 36/ for test: kms_psr2_sf
results: parsing output: 37/ for test: kms_cursor_crc
results: parsing output: 38/ for test: kms_vrr
results: parsing output: 39/ for test: kms_chamelium_color
results: parsing output: 40/ for test: gem_mmap_wc
results: parsing output: 41/ for test: kms_cursor_legacy
results: parsing output: 42/ for test: gem_exec_schedule
results: parsing output: 43/ for test: syncobj_wait
results: parsing output: 44/ for test: gem_exec_schedule
results: parsing output: 45/ for test: gem_exec_balancer
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: gem_partial_pwrite_pread
results: parsing output: 48/ for test: kms_pm_rpm
results: parsing output: 49/ for test: kms_plane_multiple
results: parsing output: 50/ for test: kms_ccs
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: kms_flip_scaled_crc
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gem_exec_flush
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: kms_flip
results: parsing output: 57/ for test: core_setmaster
results: parsing output: 58/ for test: gem_partial_pwrite_pread
results: parsing output: 59/ for test: kms_pm_rpm
results: parsing output: 60/ for test: syncobj_wait
results: parsing output: 61/ for test: kms_chamelium_edid
results: parsing output: 62/ for test: gem_mmap_gtt
results: parsing output: 63/ for test: kms_async_flips
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: gem_exec_alignment
results: parsing output: 66/ for test: kms_psr
results: parsing output: 67/ for test: gem_ctx_persistence
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: prime_vgem
results: parsing output: 70/ for test: kms_cursor_crc
results: parsing output: 71/ for test: gem_exec_balancer
results: parsing output: 72/ for test: sysfs_preempt_timeout
results: parsing output: 73/ for test: gem_spin_batch
results: parsing output: 74/ for test: gem_exec_gttfill
results: parsing output: 75/ for test: kms_big_fb
results: parsing output: 76/ for test: gem_ctx_persistence
results: parsing output: 77/ for test: gem_fenced_exec_thrash
results: parsing output: 78/ for test: api_intel_bb
results: parsing output: 79/ for test: gen7_exec_parse
results: parsing output: 80/ for test: gem_pxp
results: parsing output: 81/ for test: gem_softpin
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: kms_big_fb
results: parsing output: 87/ for test: i915_pm_freq_api
results: parsing output: 88/ for test: gem_unfence_active_buffers
results: parsing output: 89/ for test: syncobj_timeline
results: parsing output: 90/ for test: gem_render_copy
results: parsing output: 91/ for test: gem_wait
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: i915_drm_fdinfo
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: gem_gtt_cpu_tlb
results: parsing output: 96/ for test: gem_eio
results: parsing output: 97/ for test: core_setmaster_vs_auth
results: parsing output: 98/ for test: kms_cursor_legacy
results: parsing output: 99/ for test: kms_flip
results: parsing output: 100/ for test: kms_ccs
results: parsing output: 101/ for test: i915_pm_rps
results: parsing output: 102/ for test: kms_rotation_crc
results: parsing output: 103/ for test: perf_pmu
results: parsing output: 104/ for test: gem_render_copy
results: parsing output: 105/ for test: gem_cs_tlb
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: syncobj_timeline
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_rotation_crc
results: parsing output: 110/ for test: kms_atomic
results: parsing output: 111/ for test: kms_ccs
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_chamelium_hpd
results: parsing output: 114/ for test: kms_psr
results: parsing output: 115/ for test: kms_psr
results: parsing output: 116/ for test: gem_exec_reloc
results: parsing output: 117/ for test: kms_plane_scaling
results: parsing output: 118/ for test: gem_eio
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: gem_exec_schedule
results: parsing output: 121/ for test: gem_ccs
results: parsing output: 122/ for test: gem_exec_whisper
results: parsing output: 123/ for test: sw_sync
results: parsing output: 124/ for test: kms_legacy_colorkey
results: parsing output: 125/ for test: kms_dirtyfb
results: parsing output: 126/ for test: kms_psr2_sf
results: parsing output: 127/ for test: prime_mmap
results: parsing output: 128/ for test: syncobj_timeline
results: parsing output: 129/ for test: gem_userptr_blits
results: parsing output: 130/ for test: perf_pmu
Done.