[57.190375] Initializing watchdogs
[57.190424]   /dev/watchdog0
[57.205755] [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.210426] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.212723] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.215983] [001/131] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[57.343113] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[57.347455] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[57.468927] [002/131] (960s left) prime_vgem (sync)
[57.589737] Starting subtest: sync
[57.591677] Starting dynamic subtest: rcs0
[57.643962] Dynamic subtest rcs0: SUCCESS (0.057s)
[57.650637] Starting dynamic subtest: bcs0
[57.726458] Dynamic subtest bcs0: SUCCESS (0.082s)
[57.733218] Starting dynamic subtest: vcs0
[57.773141] Dynamic subtest vcs0: SUCCESS (0.047s)
[57.779812] Starting dynamic subtest: vcs1
[57.817822] Dynamic subtest vcs1: SUCCESS (0.044s)
[57.824712] Starting dynamic subtest: vecs0
[57.863267] Dynamic subtest vecs0: SUCCESS (0.045s)
[57.869992] Starting dynamic subtest: ccs0
[57.909714] Dynamic subtest ccs0: SUCCESS (0.046s)
[57.911959] Subtest sync: SUCCESS (0.323s)
[58.052636] [FACT prime_vgem (sync)] new: kernel.kmod_is_loaded.vgem: true
[58.055493] [003/131] (959s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[58.161360] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[58.165411] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[58.290083] [004/131] (959s left) i915_suspend (fence-restore-tiled2untiled)
[58.338025] Starting subtest: fence-restore-tiled2untiled
[58.341764] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[58.479184] [005/131] (959s left) kms_atomic_transition (plane-all-transition)
[58.572073] Starting subtest: plane-all-transition
[58.573929] Starting dynamic subtest: pipe-A-eDP-1
[61.113758] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.548s)
[61.426624] Starting dynamic subtest: pipe-B-eDP-1
[64.657423] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.244s)
[64.953518] Subtest plane-all-transition: SUCCESS (6.393s)
[65.796154] [006/131] (952s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[65.867041] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[65.970045] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.102s)
[66.067549] [007/131] (951s left) kms_color (ctm-negative)
[66.165746] Starting subtest: ctm-negative
[66.167973] Starting dynamic subtest: pipe-A-eDP-1
[66.871442] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.706s)
[66.879899] Starting dynamic subtest: pipe-B-eDP-1
[68.292306] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.422s)
[68.301243] Starting dynamic subtest: pipe-C-eDP-1
[69.660067] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.367s)
[69.668480] Starting dynamic subtest: pipe-D-eDP-1
[71.004824] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.345s)
[71.006878] Subtest ctm-negative: SUCCESS (4.842s)
[71.826072] [008/131] (946s left) syncobj_timeline (wait-for-submit-snapshot)
[71.888063] Starting subtest: wait-for-submit-snapshot
[71.968644] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[72.065970] [009/131] (945s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[72.166845] Starting subtest: fbcpsr-slowdraw
[97.417044] Subtest fbcpsr-slowdraw: SUCCESS (25.255s)
[97.600948] [010/131] (920s left) kms_joiner (basic-max-non-joiner)
[97.728217] Starting subtest: basic-max-non-joiner
[97.732406] Subtest basic-max-non-joiner: SKIP (0.000s)
[97.816834] [011/131] (920s left) kms_psr (pr-cursor-mmap-cpu)
[97.914285] Starting subtest: pr-cursor-mmap-cpu
[97.918813] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[98.013898] [012/131] (920s left) vgem_basic (create)
[98.064151] Starting subtest: create
[98.066070] Subtest create: SUCCESS (0.000s)
[98.141949] [013/131] (920s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[98.248296] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[98.252761] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[98.376507] [014/131] (919s left) kms_ccs (crc-primary-rotation-180-4-tiled-lnl-ccs)
[98.475457] Starting subtest: crc-primary-rotation-180-4-tiled-lnl-ccs
[98.479372] Subtest crc-primary-rotation-180-4-tiled-lnl-ccs: SKIP (0.000s)
[99.590486] [015/131] (918s left) kms_selftest (drm_dp_mst_helper)
[99.632493] Starting subtest: drm_dp_mst_helper
[99.641551] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[99.763266] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.123s)
[99.770686] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[99.860812] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.096s)
[99.868168] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[100.001479] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.140s)
[100.003676] Subtest drm_dp_mst_helper: SUCCESS (0.368s)
[100.194258] [016/131] (918s left) kms_lease (lease-uevent)
[100.280857] Starting subtest: lease-uevent
[101.289433] Subtest lease-uevent: SUCCESS (1.010s)
[101.390571] [017/131] (916s left) gem_exec_fence (invalid-timeline-fence-array)
[101.922524] Starting subtest: invalid-timeline-fence-array
[101.927988] Subtest invalid-timeline-fence-array: SUCCESS (0.006s)
[103.031809] [018/131] (915s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[103.131329] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[103.135841] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[103.259072] [019/131] (915s left) kms_feature_discovery (display-4x)
[103.362209] Starting subtest: display-4x
[103.366687] Subtest display-4x: SKIP (0.000s)
[103.454716] [020/131] (915s left) perf (oa-formats)
[103.589121] Starting subtest: oa-formats
[103.591255] Starting dynamic subtest: 0-rcs0
[103.607486] Dynamic subtest 0-rcs0: SUCCESS (0.019s)
[103.620457] Starting dynamic subtest: 1-vecs0
[103.632426] Dynamic subtest 1-vecs0: SUCCESS (0.023s)
[103.634802] Subtest oa-formats: SUCCESS (0.044s)
[103.681415] [021/131] (914s left) api_intel_allocator (execbuf-with-allocator)
[103.739253] Starting subtest: execbuf-with-allocator
[103.742765] Subtest execbuf-with-allocator: SUCCESS (0.006s)
[103.895146] [022/131] (914s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[103.984825] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[111.340429] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.357s)
[111.501812] [023/131] (907s left) kms_cursor_edge_walk (256x256-left-edge)
[111.624558] Starting subtest: 256x256-left-edge
[111.626686] Starting dynamic subtest: pipe-A-eDP-1
[115.048263] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.423s)
[115.057200] Starting dynamic subtest: pipe-D-eDP-1
[118.158527] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.110s)
[118.160887] Subtest 256x256-left-edge: SUCCESS (6.535s)
[118.998348] [024/131] (899s left) gem_exec_whisper (basic-fds-priority)
[119.078045] Starting subtest: basic-fds-priority
[142.571323] Subtest basic-fds-priority: SUCCESS (23.494s)
[142.782087] [025/131] (875s left) kms_sequence (get-forked-busy)
[142.878998] Starting subtest: get-forked-busy
[142.881334] Starting dynamic subtest: pipe-A-eDP-1
[144.802409] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.923s)
[144.812094] Starting dynamic subtest: pipe-B-eDP-1
[147.366036] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.563s)
[147.375201] Starting dynamic subtest: pipe-C-eDP-1
[149.980064] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.612s)
[149.988488] Starting dynamic subtest: pipe-D-eDP-1
[152.537050] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.555s)
[152.539079] Subtest get-forked-busy: SUCCESS (9.657s)
[153.422153] [026/131] (865s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[153.513047] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[153.515269] Starting dynamic subtest: pipe-A-default-mode
[153.808566] Dynamic subtest pipe-A-default-mode: SKIP (0.294s)
[153.813217] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.295s)
[154.662806] [027/131] (864s left) kms_draw_crc (draw-method-mmap-wc)
[154.761799] Starting subtest: draw-method-mmap-wc
[154.763639] Starting dynamic subtest: xrgb8888-untiled
[154.982434] Dynamic subtest xrgb8888-untiled: SUCCESS (0.222s)
[154.990632] Starting dynamic subtest: rgb565-untiled
[155.193359] Dynamic subtest rgb565-untiled: SUCCESS (0.211s)
[155.201735] Starting dynamic subtest: xrgb2101010-untiled
[155.416547] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s)
[155.430311] Starting dynamic subtest: xbgr16161616f-untiled
[155.660134] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.243s)
[155.667965] Starting dynamic subtest: xrgb8888-xtiled
[155.804581] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.144s)
[155.814159] Starting dynamic subtest: rgb565-xtiled
[155.937855] Dynamic subtest rgb565-xtiled: SUCCESS (0.132s)
[155.945463] Starting dynamic subtest: xrgb2101010-xtiled
[156.071513] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.133s)
[156.081226] Starting dynamic subtest: xbgr16161616f-xtiled
[156.215838] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.144s)
[156.225239] Starting dynamic subtest: xrgb8888-4tiled
[156.415818] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.199s)
[156.423472] Starting dynamic subtest: rgb565-4tiled
[156.571613] Dynamic subtest rgb565-4tiled: SUCCESS (0.154s)
[156.584616] Starting dynamic subtest: xrgb2101010-4tiled
[156.726965] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.154s)
[156.736715] Starting dynamic subtest: xbgr16161616f-4tiled
[156.915717] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.187s)
[156.917718] Subtest draw-method-mmap-wc: SUCCESS (2.156s)
[157.041592] [028/131] (861s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[157.147045] Starting subtest: plane-upscale-factor-0-25-with-rotation
[157.148942] Starting dynamic subtest: pipe-A
[157.372589] Dynamic subtest pipe-A: SUCCESS (0.227s)
[157.380545] Starting dynamic subtest: pipe-B
[158.623746] Dynamic subtest pipe-B: SUCCESS (1.250s)
[158.637802] Starting dynamic subtest: pipe-C
[159.954163] Dynamic subtest pipe-C: SUCCESS (1.328s)
[159.962142] Starting dynamic subtest: pipe-D
[161.285852] Dynamic subtest pipe-D: SUCCESS (1.330s)
[161.288206] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.141s)
[162.504297] [029/131] (856s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[162.612247] Starting subtest: primary-y-tiled-reflect-x-270
[162.616422] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[162.714568] [030/131] (856s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[162.812406] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[162.816709] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[162.932709] [031/131] (856s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[163.000466] Subtest writes-after-reads: SKIP (0.000s)
[163.062279] [032/131] (855s left) gem_mmap_gtt (isolation)
[163.125781] Subtest isolation: SKIP (0.000s)
[163.184603] [033/131] (855s left) gem_mmap_offset (pf-nonblock)
[163.251017] Starting subtest: pf-nonblock
[163.265299] Subtest pf-nonblock: SUCCESS (0.016s)
[163.440898] [034/131] (855s left) prime_self_import (basic-with_one_bo)
[163.478102] Starting subtest: basic-with_one_bo
[163.503060] Subtest basic-with_one_bo: SUCCESS (0.027s)
[163.645357] [035/131] (855s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[163.746208] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[163.749941] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[163.886851] [036/131] (855s left) syncobj_wait (single-wait-signaled)
[163.944565] Starting subtest: single-wait-signaled
[163.946587] Subtest single-wait-signaled: SUCCESS (0.000s)
[164.084984] [037/131] (855s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[169.138984] Starting subtest: pr-cursor-plane-update-sf
[169.143503] Subtest pr-cursor-plane-update-sf: SKIP (0.003s)
[170.002342] [038/131] (849s left) kms_cursor_crc (cursor-onscreen-256x256)
[170.243814] Starting subtest: cursor-onscreen-256x256
[170.248671] Starting dynamic subtest: pipe-A-eDP-1
[172.356943] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.109s)
[172.391294] Starting dynamic subtest: pipe-D-eDP-1
[175.151826] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.765s)
[175.154023] Subtest cursor-onscreen-256x256: SUCCESS (4.905s)
[176.057727] [039/131] (843s left) kms_vrr (flipline)
[176.159304] Starting subtest: flipline
[176.165915] Subtest flipline: SKIP (0.000s)
[176.254018] [040/131] (843s left) kms_chamelium_color (ctm-0-50)
[176.358678] Subtest ctm-0-50: SKIP (0.000s)
[176.402641] [041/131] (842s left) gem_mmap_wc (fault-concurrent)
[176.468510] Subtest fault-concurrent: SKIP (0.000s)
[176.535156] [042/131] (842s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[176.654257] Starting subtest: cursorA-vs-flipB-varying-size
[176.658643] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[176.822225] [043/131] (842s left) gem_exec_schedule (fairslice)
[176.906669] Starting subtest: fairslice
[176.908847] Starting dynamic subtest: rcs0
[178.918284] Dynamic subtest rcs0: SUCCESS (2.017s)
[178.928222] Starting dynamic subtest: bcs0
[180.938471] Dynamic subtest bcs0: SUCCESS (2.019s)
[180.947113] Starting dynamic subtest: vcs0
[182.959236] Dynamic subtest vcs0: SUCCESS (2.018s)
[182.967678] Starting dynamic subtest: vcs1
[184.974621] Dynamic subtest vcs1: SUCCESS (2.016s)
[184.983358] Starting dynamic subtest: vecs0
[186.994373] Dynamic subtest vecs0: SUCCESS (2.017s)
[187.003614] Starting dynamic subtest: ccs0
[189.011079] Dynamic subtest ccs0: SUCCESS (2.018s)
[189.013311] Subtest fairslice: SUCCESS (12.109s)
[189.335591] [044/131] (830s left) syncobj_wait (signal)
[189.404818] Starting subtest: signal
[189.407048] Subtest signal: SUCCESS (0.000s)
[189.544621] [045/131] (829s left) gem_exec_schedule (thriceslice)
[189.614011] Starting subtest: thriceslice
[189.616256] Starting dynamic subtest: rcs0
[189.661345] Dynamic subtest rcs0: SUCCESS (0.055s)
[189.671972] Starting dynamic subtest: bcs0
[189.717599] Dynamic subtest bcs0: SUCCESS (0.054s)
[189.727774] Starting dynamic subtest: vcs0
[189.750557] Dynamic subtest vcs0: SUCCESS (0.031s)
[189.758634] Starting dynamic subtest: vcs1
[189.781423] Dynamic subtest vcs1: SUCCESS (0.029s)
[189.789112] Starting dynamic subtest: vecs0
[189.834308] Dynamic subtest vecs0: SUCCESS (0.052s)
[189.843044] Starting dynamic subtest: ccs0
[189.892518] Dynamic subtest ccs0: SUCCESS (0.056s)
[189.894797] Subtest thriceslice: SUCCESS (0.288s)
[190.225990] [046/131] (829s left) gem_exec_balancer (hog)
[190.289592] Starting subtest: hog
[190.294186] Subtest hog: SKIP (0.000s)
[190.619555] [047/131] (828s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[190.724370] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[190.728686] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[190.839387] [048/131] (828s left) gem_partial_pwrite_pread (write)
[190.911764] Subtest write: SKIP (0.000s)
[190.997593] [049/131] (828s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[193.036453] Starting subtest: modeset-lpsp-stress-no-wait
[202.687149] Subtest modeset-lpsp-stress-no-wait: SUCCESS (9.648s)
[202.802028] [050/131] (816s left) kms_plane_multiple (tiling-4)
[202.907230] Starting subtest: tiling-4
[202.909080] Starting dynamic subtest: pipe-A-eDP-1
[206.717048] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.810s)
[206.726132] Starting dynamic subtest: pipe-B-eDP-1
[211.141975] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.421s)
[211.150652] Starting dynamic subtest: pipe-C-eDP-1
[215.463653] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.320s)
[215.477508] Starting dynamic subtest: pipe-D-eDP-1
[219.918175] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.456s)
[219.920654] Subtest tiling-4: SUCCESS (17.012s)
[220.752783] [051/131] (799s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[220.856767] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[220.859037] Starting dynamic subtest: pipe-A-eDP-1
[220.881243] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[220.890434] Starting dynamic subtest: pipe-B-eDP-1
[220.912233] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[220.922949] Starting dynamic subtest: pipe-C-eDP-1
[220.944748] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[220.954031] Starting dynamic subtest: pipe-D-eDP-1
[220.975579] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[220.979618] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[223.118163] [052/131] (796s left) kms_big_fb (linear-32bpp-rotate-270)
[223.216984] Starting subtest: linear-32bpp-rotate-270
[223.236024] Subtest linear-32bpp-rotate-270: SKIP (0.019s)
[223.387408] [053/131] (796s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[223.482061] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[223.484245] Starting dynamic subtest: pipe-A-default-mode
[224.669238] Dynamic subtest pipe-A-default-mode: SKIP (1.184s)
[224.673550] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.187s)
[224.864247] [054/131] (795s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[224.971371] Starting subtest: fbcpsr-indfb-scaledprimary
[230.707181] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (5.738s)
[230.834149] [055/131] (789s left) gem_exec_flush (basic-wb-ro-default)
[230.907640] Starting subtest: basic-wb-ro-default
[236.361846] Subtest basic-wb-ro-default: SUCCESS (5.454s)
[236.575830] [056/131] (783s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[236.675551] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[236.679934] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[236.793996] [057/131] (783s left) kms_flip (2x-blocking-wf_vblank)
[236.894303] Starting subtest: 2x-blocking-wf_vblank
[236.903460] Subtest 2x-blocking-wf_vblank: SKIP (0.011s)
[237.046879] [058/131] (782s left) core_setmaster (master-drop-set-root)
[237.140746] Starting subtest: master-drop-set-root
[237.151976] Subtest master-drop-set-root: SUCCESS (0.012s)
[237.199593] [059/131] (782s left) gem_partial_pwrite_pread (reads)
[237.262509] Subtest reads: SKIP (0.000s)
[237.342433] [060/131] (782s left) kms_pm_rpm (fences-dpms)
[239.062213] Starting subtest: fences-dpms
[239.067051] Subtest fences-dpms: SKIP (0.000s)
[239.621033] [061/131] (780s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[239.679102] Starting subtest: multi-wait-all-for-submit-signaled
[239.681424] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[239.811751] [062/131] (780s left) kms_chamelium_edid (dp-edid-resolution-list)
[240.200085] Subtest dp-edid-resolution-list: SKIP (0.000s)
[240.992815] [063/131] (779s left) gem_mmap_gtt (bad-object)
[241.044645] Subtest bad-object: SKIP (0.000s)
[241.111058] [064/131] (779s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[241.207739] Starting subtest: async-flip-with-page-flip-events-tiled
[241.591233] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[244.404076] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.813s)
[244.412703] Starting dynamic subtest: pipe-A-eDP-1-4
[246.577801] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.172s)
[246.586054] Starting dynamic subtest: pipe-A-eDP-1-4
[248.587875] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[248.595830] Starting dynamic subtest: pipe-A-eDP-1-x
[250.766897] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.177s)
[251.153398] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[253.945512] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.798s)
[253.954142] Starting dynamic subtest: pipe-B-eDP-1-4
[256.132133] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.185s)
[256.142864] Starting dynamic subtest: pipe-B-eDP-1-4
[258.142175] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[258.151396] Starting dynamic subtest: pipe-B-eDP-1-x
[260.343756] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.199s)
[260.732076] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[263.484947] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.763s)
[263.493502] Starting dynamic subtest: pipe-C-eDP-1-4
[265.672052] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.185s)
[265.683305] Starting dynamic subtest: pipe-C-eDP-1-4
[267.682237] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[267.695821] Starting dynamic subtest: pipe-C-eDP-1-x
[269.860663] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.177s)
[270.222437] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[273.008637] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.793s)
[273.017177] Starting dynamic subtest: pipe-D-eDP-1-4
[275.194321] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.184s)
[275.205636] Starting dynamic subtest: pipe-D-eDP-1-4
[277.204925] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[277.216565] Starting dynamic subtest: pipe-D-eDP-1-x
[279.394036] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.188s)
[279.396404] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.187s)
[280.627024] [065/131] (739s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[280.732052] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[280.735900] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[280.865795] [066/131] (739s left) gem_exec_alignment (many)
[280.935762] Starting subtest: many
[304.381199] Subtest many: SUCCESS (23.443s)
[306.908724] [067/131] (713s left) kms_psr (psr-dpms)
[307.052307] Starting subtest: psr-dpms
[307.054593] Starting dynamic subtest: eDP-1
[310.034682] Dynamic subtest eDP-1: SUCCESS (2.982s)
[310.036986] Subtest psr-dpms: SUCCESS (2.983s)
[310.921161] [068/131] (709s left) gem_ctx_persistence (engines-mixed-process)
[310.992289] Starting subtest: engines-mixed-process
[310.994739] Starting dynamic subtest: rcs0
[312.921736] Dynamic subtest rcs0: SUCCESS (1.928s)
[312.932265] Starting dynamic subtest: bcs0
[314.937049] Dynamic subtest bcs0: SUCCESS (2.014s)
[314.948171] Starting dynamic subtest: vcs0
[316.926240] Dynamic subtest vcs0: SUCCESS (1.987s)
[316.937961] Starting dynamic subtest: vcs1
[318.916229] Dynamic subtest vcs1: SUCCESS (1.988s)
[318.925938] Starting dynamic subtest: vecs0
[320.942789] Dynamic subtest vecs0: SUCCESS (2.026s)
[320.954266] Starting dynamic subtest: ccs0
[322.887568] Dynamic subtest ccs0: SUCCESS (1.940s)
[322.889576] Subtest engines-mixed-process: SUCCESS (11.893s)
[323.038275] [069/131] (697s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[323.162021] Starting subtest: 4-tiled-32bpp-rotate-180
[324.585096] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.425s)
[324.788879] [070/131] (695s left) prime_vgem (coherency-gtt)
[324.891755] Starting subtest: coherency-gtt
[324.896262] Subtest coherency-gtt: SKIP (0.000s)
[325.031437] [071/131] (695s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[325.267262] Starting subtest: cursor-rapid-movement-128x42
[325.312098] Subtest cursor-rapid-movement-128x42: SKIP (0.042s)
[325.552570] [072/131] (695s left) gem_exec_balancer (waits)
[325.614859] Starting subtest: waits
[332.085995] Subtest waits: SUCCESS (6.469s)
[332.408502] [073/131] (688s left) sysfs_preempt_timeout (invalid)
[332.473085] Starting subtest: invalid
[332.475388] Starting dynamic subtest: vecs0
[332.477664] Dynamic subtest vecs0: SUCCESS (0.000s)
[332.487660] Starting dynamic subtest: ccs0
[332.489873] Dynamic subtest ccs0: SUCCESS (0.000s)
[332.498175] Starting dynamic subtest: vcs0
[332.500344] Dynamic subtest vcs0: SUCCESS (0.000s)
[332.508681] Starting dynamic subtest: bcs0
[332.510936] Dynamic subtest bcs0: SUCCESS (0.000s)
[332.519195] Starting dynamic subtest: rcs0
[332.521429] Dynamic subtest rcs0: SUCCESS (0.000s)
[332.529953] Starting dynamic subtest: vcs1
[332.532231] Dynamic subtest vcs1: SUCCESS (0.000s)
[332.534095] Subtest invalid: SUCCESS (0.007s)
[332.631108] [074/131] (688s left) gem_spin_batch (resubmit-all)
[332.686048] Starting subtest: resubmit-all
[332.688387] Starting dynamic subtest: rcs0
[332.704061] Dynamic subtest rcs0: SUCCESS (0.018s)
[332.717006] Starting dynamic subtest: bcs0
[332.720308] Dynamic subtest bcs0: SUCCESS (0.003s)
[332.728738] Starting dynamic subtest: vcs0
[332.730627] Dynamic subtest vcs0: SUCCESS (0.003s)
[332.738812] Starting dynamic subtest: vcs1
[332.740667] Dynamic subtest vcs1: SUCCESS (0.003s)
[332.748860] Starting dynamic subtest: vecs0
[332.750795] Dynamic subtest vecs0: SUCCESS (0.002s)
[332.758897] Starting dynamic subtest: ccs0
[332.760821] Dynamic subtest ccs0: SUCCESS (0.002s)
[332.762983] Subtest resubmit-all: SUCCESS (0.036s)
[333.973564] [075/131] (686s left) gem_exec_gttfill (basic)
[334.045425] Starting subtest: basic
[337.877342] Subtest basic: SUCCESS (3.830s)
[338.091349] [076/131] (682s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[338.247910] Starting subtest: yf-tiled-16bpp-rotate-270
[338.252421] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[338.394090] [077/131] (682s left) gem_ctx_persistence (file)
[338.468093] Starting subtest: file
[338.607571] Subtest file: SUCCESS (0.142s)
[338.780775] [078/131] (682s left) gem_fenced_exec_thrash (too-many-fences)
[338.846156] Subtest too-many-fences: SKIP (0.000s)
[338.930480] [079/131] (681s left) api_intel_bb (misplaced-blitter)
[339.001625] Starting subtest: misplaced-blitter
[339.009894] Subtest misplaced-blitter: SUCCESS (0.009s)
[339.163226] [080/131] (681s left) gen7_exec_parse (basic-rejected)
[339.215333] Subtest basic-rejected: SKIP (0.000s)
[339.297201] [081/131] (681s left) gem_pxp (hw-rejects-pxp-context)
[339.411874] Starting subtest: hw-rejects-pxp-context
[339.415861] Subtest hw-rejects-pxp-context: SKIP (0.000s)
[339.561816] [082/131] (681s left) gem_softpin (evict-active-interruptible)
[339.631144] Starting subtest: evict-active-interruptible
[339.636652] Subtest evict-active-interruptible: SUCCESS (0.005s)
[339.790894] [083/131] (681s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[339.894763] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[339.898278] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[340.027817] [084/131] (681s left) syncobj_timeline (invalid-signal-zero-handles)
[340.092871] Starting subtest: invalid-signal-zero-handles
[340.094973] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[340.233581] [085/131] (680s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[340.333789] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[340.337452] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[340.481042] [086/131] (680s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[340.577489] Starting subtest: x-tiled-8bpp-rotate-270
[340.597941] Subtest x-tiled-8bpp-rotate-270: SKIP (0.020s)
[340.769260] [087/131] (680s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[340.865067] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[340.868782] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[341.014150] [088/131] (680s left) i915_pm_freq_api (freq-reset)
[341.072260] Starting subtest: freq-reset
[341.074376] Starting dynamic subtest: gt0
[341.266626] Dynamic subtest gt0: SUCCESS (0.190s)
[341.276676] Starting dynamic subtest: gt1
[341.434091] Dynamic subtest gt1: SUCCESS (0.167s)
[341.437126] Subtest freq-reset: SUCCESS (0.360s)
[341.536965] [089/131] (679s left) gem_unfence_active_buffers
[341.712114] [090/131] (679s left) syncobj_timeline (reset-unsignaled)
[341.773532] Starting subtest: reset-unsignaled
[341.775838] Subtest reset-unsignaled: SUCCESS (0.000s)
[341.912662] [091/131] (679s left) gem_render_copy (y-tiled)
[341.987403] Starting subtest: y-tiled
[341.992147] Subtest y-tiled: SKIP (0.000s)
[342.195842] [092/131] (679s left) gem_wait (busy)
[342.263566] Starting subtest: busy
[342.266046] Starting dynamic subtest: all-engines
[343.893896] Dynamic subtest all-engines: SUCCESS (1.628s)
[343.907975] Starting dynamic subtest: rcs0
[344.437591] Dynamic subtest rcs0: SUCCESS (0.542s)
[344.448831] Starting dynamic subtest: bcs0
[344.979104] Dynamic subtest bcs0: SUCCESS (0.540s)
[344.990631] Starting dynamic subtest: vcs0
[346.901514] Dynamic subtest vcs0: SUCCESS (1.920s)
[346.912978] Starting dynamic subtest: vcs1
[348.885435] Dynamic subtest vcs1: SUCCESS (1.981s)
[348.897319] Starting dynamic subtest: vecs0
[350.933339] Dynamic subtest vecs0: SUCCESS (2.045s)
[350.945662] Starting dynamic subtest: ccs0
[351.476857] Dynamic subtest ccs0: SUCCESS (0.542s)
[351.479512] Subtest busy: SUCCESS (9.213s)
[351.700197] [093/131] (669s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[351.807593] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[351.811967] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[351.924966] [094/131] (669s left) i915_drm_fdinfo (busy-check-all)
[351.970595] Starting subtest: busy-check-all
[351.972981] Starting dynamic subtest: rcs0
[351.977520] Dynamic subtest rcs0: SKIP (0.004s)
[351.988141] Starting dynamic subtest: bcs0
[351.992454] Dynamic subtest bcs0: SKIP (0.000s)
[352.001273] Starting dynamic subtest: vcs0
[352.005148] Dynamic subtest vcs0: SKIP (0.000s)
[352.013434] Starting dynamic subtest: vcs1
[352.017534] Dynamic subtest vcs1: SKIP (0.000s)
[352.025934] Starting dynamic subtest: vecs0
[352.030043] Dynamic subtest vecs0: SKIP (0.000s)
[352.038509] Starting dynamic subtest: ccs0
[352.042569] Dynamic subtest ccs0: SKIP (0.000s)
[352.046644] Subtest busy-check-all: SKIP (0.009s)
[352.083875] [095/131] (669s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[352.219448] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[359.177735] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.961s)
[359.344286] [096/131] (662s left) gem_gtt_cpu_tlb
[359.469284] [097/131] (662s left) gem_eio (wait-wedge-10ms)
[359.661367] Starting subtest: wait-wedge-10ms
[360.973561] Subtest wait-wedge-10ms: SUCCESS (1.312s)
[361.133726] [098/131] (660s left) core_setmaster_vs_auth
[361.329225] [099/131] (660s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[361.458679] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[370.469856] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (9.009s)
[371.300403] [100/131] (650s left) kms_flip (2x-absolute-wf_vblank)
[371.407235] Starting subtest: 2x-absolute-wf_vblank
[371.415747] Subtest 2x-absolute-wf_vblank: SKIP (0.011s)
[371.556084] [101/131] (650s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[371.650165] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[371.652375] Starting dynamic subtest: pipe-A-eDP-1
[371.672378] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.022s)
[371.682404] Starting dynamic subtest: pipe-B-eDP-1
[371.702282] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.022s)
[371.710936] Starting dynamic subtest: pipe-C-eDP-1
[371.730667] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.021s)
[371.739791] Starting dynamic subtest: pipe-D-eDP-1
[371.759849] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.023s)
[371.762159] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.093s)
[374.053793] [102/131] (647s left) i915_pm_rps (engine-order)
[374.120397] Starting subtest: engine-order
[380.546408] Subtest engine-order: SUCCESS (6.424s)
[380.712049] [103/131] (641s left) kms_rotation_crc (bad-pixel-format)
[380.813916] Starting subtest: bad-pixel-format
[380.818288] Subtest bad-pixel-format: SKIP (0.001s)
[380.911199] [104/131] (641s left) perf_pmu (module-unload)
[381.007983] Starting subtest: module-unload
[389.530653] Subtest module-unload: FAIL (8.420s)
[389.562447] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[389.563142] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[389.566202] [105/131] (632s left) gem_render_copy (y-tiled-to-vebox-linear)
[391.176689] Starting subtest: y-tiled-to-vebox-linear
[391.181294] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[391.330082] [FACT gem_render_copy (y-tiled-to-vebox-linear)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[391.331302] [FACT gem_render_copy (y-tiled-to-vebox-linear)] new: kernel.kmod_is_loaded.i915: true
[391.334996] [106/131] (630s left) gem_cs_tlb (engines)
[391.403206] Starting subtest: engines
[391.405581] Starting dynamic subtest: rcs0
[393.562927] Dynamic subtest rcs0: SUCCESS (2.155s)
[393.572236] Starting dynamic subtest: bcs0
[395.714637] Dynamic subtest bcs0: SUCCESS (2.151s)
[395.725621] Starting dynamic subtest: vcs0
[397.867955] Dynamic subtest vcs0: SUCCESS (2.152s)
[397.878512] Starting dynamic subtest: vcs1
[400.019453] Dynamic subtest vcs1: SUCCESS (2.150s)
[400.030089] Starting dynamic subtest: vecs0
[402.173898] Dynamic subtest vecs0: SUCCESS (2.153s)
[402.184905] Starting dynamic subtest: ccs0
[404.328429] Dynamic subtest ccs0: SUCCESS (2.153s)
[404.330809] Subtest engines: SUCCESS (12.921s)
[404.495369] [107/131] (617s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[404.603280] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[404.607395] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[404.737150] [108/131] (617s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[404.805866] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[404.807847] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[404.945258] [109/131] (617s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[405.029313] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[412.402520] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.375s)
[412.572219] [110/131] (609s left) kms_rotation_crc (exhaust-fences)
[412.677666] Starting subtest: exhaust-fences
[412.682031] Subtest exhaust-fences: SKIP (0.000s)
[412.771067] [111/131] (609s left) kms_atomic (plane-overlay-legacy)
[412.862858] Starting subtest: plane-overlay-legacy
[412.865142] Starting dynamic subtest: pipe-A-eDP-1
[413.272080] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.409s)
[413.274395] Subtest plane-overlay-legacy: SUCCESS (0.410s)
[414.161067] [112/131] (608s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[414.266874] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[414.269200] Starting dynamic subtest: pipe-A-eDP-1
[414.572726] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.273s)
[414.587976] Starting dynamic subtest: pipe-B-eDP-1
[415.805834] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.232s)
[415.816726] Starting dynamic subtest: pipe-C-eDP-1
[417.019050] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.205s)
[417.033822] Starting dynamic subtest: pipe-D-eDP-1
[418.251620] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.240s)
[418.253552] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (3.956s)
[419.494616] [113/131] (602s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[419.596289] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[419.600639] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[419.713922] [114/131] (602s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[420.112608] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[420.883456] [115/131] (601s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[420.966891] Starting subtest: fbc-psr2-sprite-plane-onoff
[420.969084] Starting dynamic subtest: eDP-1
[420.973040] Dynamic subtest eDP-1: SKIP (0.000s)
[420.977128] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s)
[421.063429] [116/131] (601s left) kms_psr (pr-primary-page-flip)
[421.146916] Starting subtest: pr-primary-page-flip
[421.151167] Subtest pr-primary-page-flip: SKIP (0.000s)
[421.251062] [117/131] (601s left) gem_exec_reloc (basic-wc-gtt)
[421.318065] Subtest basic-wc-gtt: SKIP (0.000s)
[421.399217] [118/131] (601s left) kms_plane_scaling (intel-max-src-size)
[421.507212] Starting subtest: intel-max-src-size
[421.513313] Subtest intel-max-src-size: SKIP (0.000s)
[421.648368] [119/131] (600s left) gem_eio (in-flight-1us)
[421.890434] Starting subtest: in-flight-1us
[430.951390] Subtest in-flight-1us: SUCCESS (9.060s)
[431.150581] [120/131] (591s left) kms_psr (fbc-pr-dpms)
[431.246066] Starting subtest: fbc-pr-dpms
[431.250425] Subtest fbc-pr-dpms: SKIP (0.000s)
[431.344553] [121/131] (591s left) gem_exec_schedule (noreorder)
[431.535780] Starting subtest: noreorder
[431.538228] Starting dynamic subtest: rcs0
[431.612463] Dynamic subtest rcs0: SUCCESS (0.075s)
[431.624591] Starting dynamic subtest: vcs0
[432.947345] Dynamic subtest vcs0: SUCCESS (1.332s)
[432.958337] Starting dynamic subtest: vcs1
[434.883770] Dynamic subtest vcs1: SUCCESS (1.934s)
[434.898046] Starting dynamic subtest: vecs0
[436.912308] Dynamic subtest vecs0: SUCCESS (2.026s)
[436.924060] Starting dynamic subtest: ccs0
[437.017186] Dynamic subtest ccs0: SUCCESS (0.103s)
[437.019894] Subtest noreorder: SUCCESS (5.482s)
[437.229507] [122/131] (585s left) gem_ccs (block-multicopy-inplace)
[437.293411] Starting subtest: block-multicopy-inplace
[437.298159] Subtest block-multicopy-inplace: SKIP (0.000s)
[437.441519] [123/131] (585s left) gem_exec_whisper (basic-queues-priority)
[437.505358] Starting subtest: basic-queues-priority
[461.902574] Subtest basic-queues-priority: SUCCESS (24.395s)
[462.115342] [124/131] (560s left) sw_sync (sync_merge)
[462.152273] Starting subtest: sync_merge
[462.154862] Subtest sync_merge: SUCCESS (0.000s)
[462.245399] [125/131] (560s left) kms_legacy_colorkey (invalid-plane)
[462.354755] Starting subtest: invalid-plane
[462.357017] Starting dynamic subtest: zero-id
[462.358933] Dynamic subtest zero-id: SUCCESS (0.000s)
[462.378515] Starting dynamic subtest: outrange-id
[462.380726] Dynamic subtest outrange-id: SUCCESS (0.000s)
[462.382963] Subtest invalid-plane: SUCCESS (0.002s)
[462.455320] [126/131] (560s left) kms_dirtyfb (default-dirtyfb-ioctl)
[462.565154] Starting subtest: default-dirtyfb-ioctl
[462.567042] Starting dynamic subtest: A-eDP-1
[464.198495] Dynamic subtest A-eDP-1: SUCCESS (1.631s)
[464.200703] Subtest default-dirtyfb-ioctl: SUCCESS (1.632s)
[465.065149] [127/131] (557s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[470.115829] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[470.120497] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.002s)
[471.004593] [128/131] (551s left) prime_mmap (test_map_unmap)
[471.074890] Starting subtest: test_map_unmap
[471.077317] Starting dynamic subtest: test_map_unmap-smem
[471.121555] Dynamic subtest test_map_unmap-smem: SUCCESS (0.048s)
[471.124232] Subtest test_map_unmap: SUCCESS (0.049s)
[471.270470] [129/131] (551s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[471.335882] Starting subtest: etime-multi-wait-all-for-submit-submitted
[471.442521] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.106s)
[471.543061] [130/131] (551s left) gem_userptr_blits (process-exit)
[471.620758] Starting subtest: process-exit
[471.626061] Subtest process-exit: SUCCESS (0.007s)
[471.791371] [131/131] (551s left) perf_pmu (busy-idle-check-all)
[471.835781] Starting subtest: busy-idle-check-all
[471.838139] Starting dynamic subtest: rcs0
[472.502965] Dynamic subtest rcs0: SUCCESS (0.667s)
[472.515371] Starting dynamic subtest: bcs0
[473.152733] Dynamic subtest bcs0: SUCCESS (0.648s)
[473.164971] Starting dynamic subtest: vcs0
[474.903193] Dynamic subtest vcs0: SUCCESS (1.746s)
[474.915902] Starting dynamic subtest: vcs1
[476.887396] Dynamic subtest vcs1: SUCCESS (1.981s)
[476.899816] Starting dynamic subtest: vecs0
[478.933820] Dynamic subtest vecs0: SUCCESS (2.044s)
[478.945851] Starting dynamic subtest: ccs0
[479.590335] Dynamic subtest ccs0: SUCCESS (0.655s)
[479.592905] Subtest busy-idle-check-all: SUCCESS (7.755s)
[479.728857] 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.