[57.217927] Initializing watchdogs
[57.217976]   /dev/watchdog0
[57.231479] [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.235651] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.237784] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.241119] [001/131] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[57.377670] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[57.381880] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[57.519341] [002/131] (960s left) prime_vgem (sync)
[57.630673] Starting subtest: sync
[57.633087] Starting dynamic subtest: rcs0
[57.674838] Dynamic subtest rcs0: SUCCESS (0.044s)
[57.681825] Starting dynamic subtest: bcs0
[57.722668] Dynamic subtest bcs0: SUCCESS (0.047s)
[57.729203] Starting dynamic subtest: vcs0
[57.770497] Dynamic subtest vcs0: SUCCESS (0.047s)
[57.777377] Starting dynamic subtest: vcs1
[57.816580] Dynamic subtest vcs1: SUCCESS (0.045s)
[57.823165] Starting dynamic subtest: vecs0
[57.861494] Dynamic subtest vecs0: SUCCESS (0.045s)
[57.868344] Starting dynamic subtest: ccs0
[57.907000] Dynamic subtest ccs0: SUCCESS (0.045s)
[57.909375] Subtest sync: SUCCESS (0.275s)
[58.070963] [FACT prime_vgem (sync)] new: kernel.kmod_is_loaded.vgem: true
[58.074065] [003/131] (959s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[58.185224] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[58.190000] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[58.316715] [004/131] (959s left) i915_suspend (fence-restore-tiled2untiled)
[58.383720] Starting subtest: fence-restore-tiled2untiled
[58.387869] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[58.507324] [005/131] (959s left) kms_atomic_transition (plane-all-transition)
[58.601720] Starting subtest: plane-all-transition
[58.603627] Starting dynamic subtest: pipe-A-eDP-1
[61.157342] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.540s)
[61.466319] Starting dynamic subtest: pipe-B-eDP-1
[64.754706] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.286s)
[65.053898] Subtest plane-all-transition: SUCCESS (6.420s)
[65.899440] [006/131] (952s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[65.951696] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[66.057986] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.105s)
[66.156125] [007/131] (951s left) kms_color (ctm-negative)
[66.257060] Starting subtest: ctm-negative
[66.259032] Starting dynamic subtest: pipe-A-eDP-1
[66.967440] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.710s)
[66.976308] Starting dynamic subtest: pipe-B-eDP-1
[68.399662] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.426s)
[68.408084] Starting dynamic subtest: pipe-C-eDP-1
[69.775842] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.375s)
[69.784164] Starting dynamic subtest: pipe-D-eDP-1
[71.106560] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.327s)
[71.108829] Subtest ctm-negative: SUCCESS (4.841s)
[71.941781] [008/131] (946s left) syncobj_timeline (wait-for-submit-snapshot)
[71.996854] Starting subtest: wait-for-submit-snapshot
[72.079450] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[72.180749] [009/131] (945s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[72.276402] Starting subtest: fbcpsr-slowdraw
[97.447777] Subtest fbcpsr-slowdraw: SUCCESS (25.167s)
[97.619474] [010/131] (920s left) kms_joiner (basic-max-non-joiner)
[97.729682] Starting subtest: basic-max-non-joiner
[97.733937] Subtest basic-max-non-joiner: SKIP (0.000s)
[97.818608] [011/131] (920s left) kms_psr (pr-cursor-mmap-cpu)
[97.919667] Starting subtest: pr-cursor-mmap-cpu
[97.924053] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[98.011796] [012/131] (920s left) vgem_basic (create)
[98.056546] Starting subtest: create
[98.058506] Subtest create: SUCCESS (0.000s)
[98.137713] [013/131] (920s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[98.234593] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[98.237910] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[98.363759] [014/131] (919s left) kms_ccs (crc-primary-rotation-180-4-tiled-lnl-ccs)
[98.452614] Starting subtest: crc-primary-rotation-180-4-tiled-lnl-ccs
[98.456464] Subtest crc-primary-rotation-180-4-tiled-lnl-ccs: SKIP (0.000s)
[99.604079] [015/131] (918s left) kms_selftest (drm_dp_mst_helper)
[99.650590] Starting subtest: drm_dp_mst_helper
[99.660298] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[99.775249] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.116s)
[99.782098] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[99.933306] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.155s)
[99.941042] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[100.086220] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.154s)
[100.088476] Subtest drm_dp_mst_helper: SUCCESS (0.438s)
[100.323428] [016/131] (917s left) kms_lease (lease-uevent)
[100.425204] Starting subtest: lease-uevent
[101.432814] Subtest lease-uevent: SUCCESS (1.010s)
[101.528229] [017/131] (916s left) gem_exec_fence (invalid-timeline-fence-array)
[102.067729] Starting subtest: invalid-timeline-fence-array
[102.073913] Subtest invalid-timeline-fence-array: SUCCESS (0.005s)
[104.042821] [018/131] (914s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[104.168134] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[104.172395] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[104.298821] [019/131] (914s left) kms_feature_discovery (display-4x)
[104.393801] Starting subtest: display-4x
[104.398121] Subtest display-4x: SKIP (0.000s)
[104.486497] [020/131] (913s left) perf (oa-formats)
[104.630149] Starting subtest: oa-formats
[104.632585] Starting dynamic subtest: 0-rcs0
[104.646108] Dynamic subtest 0-rcs0: SUCCESS (0.016s)
[104.655817] Starting dynamic subtest: 1-vcs0
[104.672083] Dynamic subtest 1-vcs0: SUCCESS (0.026s)
[104.674378] Subtest oa-formats: SUCCESS (0.043s)
[104.717828] [021/131] (913s left) api_intel_allocator (execbuf-with-allocator)
[104.781087] Starting subtest: execbuf-with-allocator
[104.785695] Subtest execbuf-with-allocator: SUCCESS (0.007s)
[104.901340] [022/131] (913s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[105.002904] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[112.423261] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.423s)
[112.590291] [023/131] (906s left) kms_cursor_edge_walk (256x256-left-edge)
[112.719977] Starting subtest: 256x256-left-edge
[112.722507] Starting dynamic subtest: pipe-A-eDP-1
[116.182447] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.463s)
[116.190016] Starting dynamic subtest: pipe-D-eDP-1
[119.301594] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.118s)
[119.303914] Subtest 256x256-left-edge: SUCCESS (6.583s)
[120.124494] [024/131] (898s left) gem_exec_whisper (basic-fds-priority)
[120.211139] Starting subtest: basic-fds-priority
[144.230630] Subtest basic-fds-priority: SUCCESS (24.015s)
[144.436458] [025/131] (874s left) kms_sequence (get-forked-busy)
[144.549106] Starting subtest: get-forked-busy
[144.551471] Starting dynamic subtest: pipe-A-eDP-1
[146.493399] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.942s)
[146.501569] Starting dynamic subtest: pipe-B-eDP-1
[149.110922] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.615s)
[149.119803] Starting dynamic subtest: pipe-C-eDP-1
[151.725813] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.615s)
[151.736339] Starting dynamic subtest: pipe-D-eDP-1
[154.348809] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.621s)
[154.351271] Subtest get-forked-busy: SUCCESS (9.798s)
[155.255476] [026/131] (863s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[155.377283] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[155.379619] Starting dynamic subtest: pipe-A-default-mode
[155.678674] Dynamic subtest pipe-A-default-mode: SKIP (0.299s)
[155.683057] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.300s)
[156.491513] [027/131] (862s left) kms_draw_crc (draw-method-mmap-wc)
[156.589129] Starting subtest: draw-method-mmap-wc
[156.591060] Starting dynamic subtest: xrgb8888-untiled
[156.843321] Dynamic subtest xrgb8888-untiled: SUCCESS (0.255s)
[156.851897] Starting dynamic subtest: rgb565-untiled
[157.054448] Dynamic subtest rgb565-untiled: SUCCESS (0.210s)
[157.064440] Starting dynamic subtest: xrgb2101010-untiled
[157.265734] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.210s)
[157.274700] Starting dynamic subtest: xbgr16161616f-untiled
[157.531913] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.266s)
[157.539744] Starting dynamic subtest: xrgb8888-xtiled
[157.665315] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.133s)
[157.672490] Starting dynamic subtest: rgb565-xtiled
[157.798857] Dynamic subtest rgb565-xtiled: SUCCESS (0.132s)
[157.806449] Starting dynamic subtest: xrgb2101010-xtiled
[157.909777] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s)
[157.917545] Starting dynamic subtest: xbgr16161616f-xtiled
[158.043079] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[158.050440] Starting dynamic subtest: xrgb8888-4tiled
[158.198909] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.155s)
[158.206124] Starting dynamic subtest: rgb565-4tiled
[158.354234] Dynamic subtest rgb565-4tiled: SUCCESS (0.153s)
[158.361255] Starting dynamic subtest: xrgb2101010-4tiled
[158.487864] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.133s)
[158.495491] Starting dynamic subtest: xbgr16161616f-4tiled
[158.643148] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.155s)
[158.645068] Subtest draw-method-mmap-wc: SUCCESS (2.056s)
[158.781417] [028/131] (860s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[158.889795] Starting subtest: plane-upscale-factor-0-25-with-rotation
[158.891730] Starting dynamic subtest: pipe-A
[159.115645] Dynamic subtest pipe-A: SUCCESS (0.228s)
[159.122978] Starting dynamic subtest: pipe-B
[160.462342] Dynamic subtest pipe-B: SUCCESS (1.345s)
[160.472869] Starting dynamic subtest: pipe-C
[161.802432] Dynamic subtest pipe-C: SUCCESS (1.339s)
[161.810125] Starting dynamic subtest: pipe-D
[163.117923] Dynamic subtest pipe-D: SUCCESS (1.315s)
[163.120293] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.230s)
[164.320046] [029/131] (854s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[164.422664] Starting subtest: primary-y-tiled-reflect-x-270
[164.427117] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[164.557460] [030/131] (854s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[164.663134] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[164.667064] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[164.779452] [031/131] (854s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[164.843740] Subtest writes-after-reads: SKIP (0.000s)
[164.905818] [032/131] (854s left) gem_mmap_gtt (isolation)
[164.971805] Subtest isolation: SKIP (0.000s)
[165.040713] [033/131] (853s left) gem_mmap_offset (pf-nonblock)
[165.094823] Starting subtest: pf-nonblock
[165.101770] Subtest pf-nonblock: SUCCESS (0.007s)
[165.261382] [034/131] (853s left) prime_self_import (basic-with_one_bo)
[165.297714] Starting subtest: basic-with_one_bo
[165.324779] Subtest basic-with_one_bo: SUCCESS (0.026s)
[165.458578] [035/131] (853s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[165.565148] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[165.568392] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[165.676677] [036/131] (853s left) syncobj_wait (single-wait-signaled)
[165.730264] Starting subtest: single-wait-signaled
[165.732207] Subtest single-wait-signaled: SUCCESS (0.000s)
[165.863941] [037/131] (853s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[170.901362] Starting subtest: pr-cursor-plane-update-sf
[170.905918] Subtest pr-cursor-plane-update-sf: SKIP (0.002s)
[171.768846] [038/131] (847s left) kms_cursor_crc (cursor-onscreen-256x256)
[172.012273] Starting subtest: cursor-onscreen-256x256
[172.016827] Starting dynamic subtest: pipe-A-eDP-1
[174.099821] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.083s)
[174.126695] Starting dynamic subtest: pipe-D-eDP-1
[176.901073] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.778s)
[176.903405] Subtest cursor-onscreen-256x256: SUCCESS (4.887s)
[177.730444] [039/131] (841s left) kms_vrr (flipline)
[177.832630] Starting subtest: flipline
[177.839159] Subtest flipline: SKIP (0.000s)
[177.929281] [040/131] (841s left) kms_chamelium_color (ctm-0-50)
[178.027842] Subtest ctm-0-50: SKIP (0.000s)
[178.070419] [041/131] (841s left) gem_mmap_wc (fault-concurrent)
[178.130833] Subtest fault-concurrent: SKIP (0.000s)
[178.193783] [042/131] (841s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[178.309491] Starting subtest: cursorA-vs-flipB-varying-size
[178.314032] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[178.498513] [043/131] (840s left) gem_exec_schedule (fairslice)
[178.581344] Starting subtest: fairslice
[178.583660] Starting dynamic subtest: rcs0
[180.590984] Dynamic subtest rcs0: SUCCESS (2.017s)
[180.600501] Starting dynamic subtest: bcs0
[182.610084] Dynamic subtest bcs0: SUCCESS (2.018s)
[182.619065] Starting dynamic subtest: vcs0
[184.630579] Dynamic subtest vcs0: SUCCESS (2.018s)
[184.638802] Starting dynamic subtest: vcs1
[186.646200] Dynamic subtest vcs1: SUCCESS (2.015s)
[186.655326] Starting dynamic subtest: vecs0
[188.662267] Dynamic subtest vecs0: SUCCESS (2.013s)
[188.681065] Starting dynamic subtest: ccs0
[190.679815] Dynamic subtest ccs0: SUCCESS (2.017s)
[190.681854] Subtest fairslice: SUCCESS (12.103s)
[190.998314] [044/131] (828s left) syncobj_wait (signal)
[191.059299] Starting subtest: signal
[191.061614] Subtest signal: SUCCESS (0.000s)
[191.173447] [045/131] (828s left) gem_exec_schedule (thriceslice)
[191.243588] Starting subtest: thriceslice
[191.245555] Starting dynamic subtest: rcs0
[191.289549] Dynamic subtest rcs0: SUCCESS (0.057s)
[191.300683] Starting dynamic subtest: bcs0
[191.332324] Dynamic subtest bcs0: SUCCESS (0.040s)
[191.342174] Starting dynamic subtest: vcs0
[191.366669] Dynamic subtest vcs0: SUCCESS (0.033s)
[191.375119] Starting dynamic subtest: vcs1
[191.418294] Dynamic subtest vcs1: SUCCESS (0.051s)
[191.428849] Starting dynamic subtest: vecs0
[191.473023] Dynamic subtest vecs0: SUCCESS (0.052s)
[191.486079] Starting dynamic subtest: ccs0
[191.531842] Dynamic subtest ccs0: SUCCESS (0.057s)
[191.534497] Subtest thriceslice: SUCCESS (0.301s)
[191.855618] [046/131] (827s left) gem_exec_balancer (hog)
[191.923099] Starting subtest: hog
[191.927480] Subtest hog: SKIP (0.000s)
[192.256067] [047/131] (827s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[192.356536] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[192.361057] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[192.477969] [048/131] (827s left) gem_partial_pwrite_pread (write)
[192.542378] Subtest write: SKIP (0.000s)
[192.601803] [049/131] (827s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[194.131255] Starting subtest: modeset-lpsp-stress-no-wait
[204.058258] Subtest modeset-lpsp-stress-no-wait: SUCCESS (9.927s)
[204.174521] [050/131] (815s left) kms_plane_multiple (tiling-4)
[204.292791] Starting subtest: tiling-4
[204.295031] Starting dynamic subtest: pipe-A-eDP-1
[208.156421] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.859s)
[208.165209] Starting dynamic subtest: pipe-B-eDP-1
[212.574580] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.418s)
[212.584352] Starting dynamic subtest: pipe-C-eDP-1
[216.904155] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.326s)
[216.912139] Starting dynamic subtest: pipe-D-eDP-1
[221.252803] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.348s)
[221.255080] Subtest tiling-4: SUCCESS (16.958s)
[222.087750] [051/131] (797s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[222.194719] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[222.196941] Starting dynamic subtest: pipe-A-eDP-1
[222.219368] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[222.229916] Starting dynamic subtest: pipe-B-eDP-1
[222.250808] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[222.258979] Starting dynamic subtest: pipe-C-eDP-1
[222.280324] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[222.289171] Starting dynamic subtest: pipe-D-eDP-1
[222.310710] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[222.314854] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[224.448349] [052/131] (795s left) kms_big_fb (linear-32bpp-rotate-270)
[224.560605] Starting subtest: linear-32bpp-rotate-270
[224.580089] Subtest linear-32bpp-rotate-270: SKIP (0.019s)
[224.727990] [053/131] (795s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[224.832725] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[224.834963] Starting dynamic subtest: pipe-A-default-mode
[225.991694] Dynamic subtest pipe-A-default-mode: SKIP (1.157s)
[225.995857] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.158s)
[226.158238] [054/131] (793s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[226.259401] Starting subtest: fbcpsr-indfb-scaledprimary
[232.029550] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (5.773s)
[232.219226] [055/131] (787s left) gem_exec_flush (basic-wb-ro-default)
[232.299681] Starting subtest: basic-wb-ro-default
[237.747432] Subtest basic-wb-ro-default: SUCCESS (5.450s)
[237.969958] [056/131] (781s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[238.086060] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[238.090483] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[238.215450] [057/131] (781s left) kms_flip (2x-blocking-wf_vblank)
[238.315969] Starting subtest: 2x-blocking-wf_vblank
[238.324893] Subtest 2x-blocking-wf_vblank: SKIP (0.010s)
[238.426368] [058/131] (781s left) core_setmaster (master-drop-set-root)
[238.509933] Starting subtest: master-drop-set-root
[238.521523] Subtest master-drop-set-root: SUCCESS (0.012s)
[238.567378] [059/131] (781s left) gem_partial_pwrite_pread (reads)
[238.627436] Subtest reads: SKIP (0.000s)
[238.710311] [060/131] (781s left) kms_pm_rpm (fences-dpms)
[240.227923] Starting subtest: fences-dpms
[240.232993] Subtest fences-dpms: SKIP (0.000s)
[241.033732] [061/131] (779s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[241.099642] Starting subtest: multi-wait-all-for-submit-signaled
[241.101919] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[241.207051] [062/131] (778s left) kms_chamelium_edid (dp-edid-resolution-list)
[241.592220] Subtest dp-edid-resolution-list: SKIP (0.000s)
[242.413078] [063/131] (777s left) gem_mmap_gtt (bad-object)
[242.479205] Subtest bad-object: SKIP (0.000s)
[242.548747] [064/131] (777s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[242.643763] Starting subtest: async-flip-with-page-flip-events-tiled
[243.024834] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[245.808044] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.781s)
[245.819234] Starting dynamic subtest: pipe-A-eDP-1-4
[247.984735] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.175s)
[247.993247] Starting dynamic subtest: pipe-A-eDP-1-4
[249.993245] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.007s)
[250.001129] Starting dynamic subtest: pipe-A-eDP-1-x
[252.186102] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.189s)
[252.575153] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[255.332784] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.767s)
[255.341751] Starting dynamic subtest: pipe-B-eDP-1-4
[257.520841] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.185s)
[257.538198] Starting dynamic subtest: pipe-B-eDP-1-4
[259.530228] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.007s)
[259.545097] Starting dynamic subtest: pipe-B-eDP-1-x
[261.719752] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.188s)
[262.084402] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[264.870559] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.792s)
[264.879424] Starting dynamic subtest: pipe-C-eDP-1-4
[267.045669] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s)
[267.054097] Starting dynamic subtest: pipe-C-eDP-1-4
[269.056351] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[269.067078] Starting dynamic subtest: pipe-C-eDP-1-x
[271.234973] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.177s)
[271.598860] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[274.405743] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.812s)
[274.414769] Starting dynamic subtest: pipe-D-eDP-1-4
[276.570504] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.163s)
[276.579237] Starting dynamic subtest: pipe-D-eDP-1-4
[278.580432] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[278.594569] Starting dynamic subtest: pipe-D-eDP-1-x
[280.758020] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.177s)
[280.760402] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.116s)
[282.023904] [065/131] (738s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[282.134386] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[282.138616] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[282.276055] [066/131] (738s left) gem_exec_alignment (many)
[282.336075] Starting subtest: many
[304.345798] Subtest many: SUCCESS (22.010s)
[305.698133] [067/131] (714s left) kms_psr (psr-dpms)
[305.824228] Starting subtest: psr-dpms
[305.826522] Starting dynamic subtest: eDP-1
[308.814669] Dynamic subtest eDP-1: SUCCESS (2.990s)
[308.816930] Subtest psr-dpms: SUCCESS (2.991s)
[309.706206] [068/131] (710s left) gem_ctx_persistence (engines-mixed-process)
[309.790488] Starting subtest: engines-mixed-process
[309.793042] Starting dynamic subtest: rcs0
[311.944267] Dynamic subtest rcs0: SUCCESS (2.153s)
[311.954793] Starting dynamic subtest: bcs0
[313.904039] Dynamic subtest bcs0: SUCCESS (1.958s)
[313.915389] Starting dynamic subtest: vcs0
[315.869900] Dynamic subtest vcs0: SUCCESS (1.965s)
[315.880177] Starting dynamic subtest: vcs1
[317.944556] Dynamic subtest vcs1: SUCCESS (2.073s)
[317.955039] Starting dynamic subtest: vecs0
[319.930581] Dynamic subtest vecs0: SUCCESS (1.983s)
[319.941952] Starting dynamic subtest: ccs0
[321.903053] Dynamic subtest ccs0: SUCCESS (1.971s)
[321.905474] Subtest engines-mixed-process: SUCCESS (12.114s)
[322.011700] [069/131] (698s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[322.132668] Starting subtest: 4-tiled-32bpp-rotate-180
[323.509504] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.378s)
[323.673303] [070/131] (696s left) prime_vgem (coherency-gtt)
[323.777790] Starting subtest: coherency-gtt
[323.781626] Subtest coherency-gtt: SKIP (0.000s)
[323.901598] [071/131] (696s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[324.128296] Starting subtest: cursor-rapid-movement-128x42
[324.175620] Subtest cursor-rapid-movement-128x42: SKIP (0.043s)
[324.441896] [072/131] (696s left) gem_exec_balancer (waits)
[324.512324] Starting subtest: waits
[330.953705] Subtest waits: SUCCESS (6.439s)
[331.288212] [073/131] (689s left) sysfs_preempt_timeout (invalid)
[331.357602] Starting subtest: invalid
[331.359920] Starting dynamic subtest: vecs0
[331.362230] Dynamic subtest vecs0: SUCCESS (0.000s)
[331.372059] Starting dynamic subtest: ccs0
[331.374262] Dynamic subtest ccs0: SUCCESS (0.000s)
[331.382301] Starting dynamic subtest: vcs0
[331.384515] Dynamic subtest vcs0: SUCCESS (0.000s)
[331.392811] Starting dynamic subtest: bcs0
[331.395057] Dynamic subtest bcs0: SUCCESS (0.000s)
[331.403336] Starting dynamic subtest: rcs0
[331.405549] Dynamic subtest rcs0: SUCCESS (0.000s)
[331.413824] Starting dynamic subtest: vcs1
[331.415719] Dynamic subtest vcs1: SUCCESS (0.000s)
[331.417666] Subtest invalid: SUCCESS (0.005s)
[331.507906] [074/131] (689s left) gem_spin_batch (resubmit-all)
[331.581244] Starting subtest: resubmit-all
[331.583535] Starting dynamic subtest: rcs0
[331.599137] Dynamic subtest rcs0: SUCCESS (0.018s)
[331.610824] Starting dynamic subtest: bcs0
[331.613093] Dynamic subtest bcs0: SUCCESS (0.003s)
[331.620837] Starting dynamic subtest: vcs0
[331.622732] Dynamic subtest vcs0: SUCCESS (0.002s)
[331.630657] Starting dynamic subtest: vcs1
[331.632532] Dynamic subtest vcs1: SUCCESS (0.002s)
[331.640282] Starting dynamic subtest: vecs0
[331.642118] Dynamic subtest vecs0: SUCCESS (0.002s)
[331.650249] Starting dynamic subtest: ccs0
[331.652137] Dynamic subtest ccs0: SUCCESS (0.002s)
[331.654194] Subtest resubmit-all: SUCCESS (0.031s)
[332.950748] [075/131] (687s left) gem_exec_gttfill (basic)
[333.022664] Starting subtest: basic
[336.110530] Subtest basic: SUCCESS (3.087s)
[336.323857] [076/131] (684s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[336.463960] Starting subtest: yf-tiled-16bpp-rotate-270
[336.468499] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[336.601397] [077/131] (684s left) gem_ctx_persistence (file)
[336.670782] Starting subtest: file
[336.830616] Subtest file: SUCCESS (0.160s)
[336.994526] [078/131] (683s left) gem_fenced_exec_thrash (too-many-fences)
[337.053981] Subtest too-many-fences: SKIP (0.000s)
[337.149583] [079/131] (683s left) api_intel_bb (misplaced-blitter)
[337.210627] Starting subtest: misplaced-blitter
[337.215705] Subtest misplaced-blitter: SUCCESS (0.007s)
[337.358489] [080/131] (683s left) gen7_exec_parse (basic-rejected)
[337.410452] Subtest basic-rejected: SKIP (0.000s)
[337.493892] [081/131] (683s left) gem_pxp (hw-rejects-pxp-context)
[337.624048] Starting subtest: hw-rejects-pxp-context
[337.627826] Subtest hw-rejects-pxp-context: SKIP (0.000s)
[337.763885] [082/131] (683s left) gem_softpin (evict-active-interruptible)
[337.834435] Starting subtest: evict-active-interruptible
[337.840432] Subtest evict-active-interruptible: SUCCESS (0.006s)
[338.000977] [083/131] (683s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[338.108465] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[338.111824] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[338.245252] [084/131] (682s left) syncobj_timeline (invalid-signal-zero-handles)
[338.310644] Starting subtest: invalid-signal-zero-handles
[338.312657] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[338.442795] [085/131] (682s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[338.527248] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[338.530700] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[338.647080] [086/131] (682s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[338.756494] Starting subtest: x-tiled-8bpp-rotate-270
[338.776474] Subtest x-tiled-8bpp-rotate-270: SKIP (0.019s)
[338.917650] [087/131] (682s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[339.030107] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[339.033972] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[339.164965] [088/131] (682s left) i915_pm_freq_api (freq-reset)
[339.232928] Starting subtest: freq-reset
[339.234976] Starting dynamic subtest: gt0
[339.427125] Dynamic subtest gt0: SUCCESS (0.192s)
[339.436827] Starting dynamic subtest: gt1
[339.591636] Dynamic subtest gt1: SUCCESS (0.163s)
[339.594245] Subtest freq-reset: SUCCESS (0.358s)
[339.691871] [089/131] (681s left) gem_unfence_active_buffers
[339.854280] [090/131] (681s left) syncobj_timeline (reset-unsignaled)
[339.909411] Starting subtest: reset-unsignaled
[339.911359] Subtest reset-unsignaled: SUCCESS (0.000s)
[340.041667] [091/131] (681s left) gem_render_copy (y-tiled)
[340.100092] Starting subtest: y-tiled
[340.104640] Subtest y-tiled: SKIP (0.000s)
[340.306917] [092/131] (681s left) gem_wait (busy)
[340.367756] Starting subtest: busy
[340.370090] Starting dynamic subtest: all-engines
[341.909215] Dynamic subtest all-engines: SUCCESS (1.539s)
[341.920995] Starting dynamic subtest: rcs0
[342.451440] Dynamic subtest rcs0: SUCCESS (0.541s)
[342.462652] Starting dynamic subtest: bcs0
[342.991147] Dynamic subtest bcs0: SUCCESS (0.539s)
[343.002435] Starting dynamic subtest: vcs0
[344.917435] Dynamic subtest vcs0: SUCCESS (1.924s)
[344.929064] Starting dynamic subtest: vcs1
[346.900909] Dynamic subtest vcs1: SUCCESS (1.981s)
[346.912688] Starting dynamic subtest: vecs0
[348.885116] Dynamic subtest vecs0: SUCCESS (1.982s)
[348.896824] Starting dynamic subtest: ccs0
[349.428374] Dynamic subtest ccs0: SUCCESS (0.542s)
[349.430687] Subtest busy: SUCCESS (9.061s)
[349.650385] [093/131] (671s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[349.768548] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[349.772812] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[349.889856] [094/131] (671s left) i915_drm_fdinfo (busy-check-all)
[349.925976] Starting subtest: busy-check-all
[349.928338] Starting dynamic subtest: rcs0
[349.932760] Dynamic subtest rcs0: SKIP (0.003s)
[349.941733] Starting dynamic subtest: bcs0
[349.945494] Dynamic subtest bcs0: SKIP (0.000s)
[349.954059] Starting dynamic subtest: vcs0
[349.958260] Dynamic subtest vcs0: SKIP (0.000s)
[349.966548] Starting dynamic subtest: vcs1
[349.970666] Dynamic subtest vcs1: SKIP (0.000s)
[349.979063] Starting dynamic subtest: vecs0
[349.983118] Dynamic subtest vecs0: SKIP (0.000s)
[349.991240] Starting dynamic subtest: ccs0
[349.995408] Dynamic subtest ccs0: SKIP (0.000s)
[349.999603] Subtest busy-check-all: SKIP (0.008s)
[350.034546] [095/131] (671s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[350.165280] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[357.143064] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.979s)
[357.307742] [096/131] (664s left) gem_gtt_cpu_tlb
[357.444898] [097/131] (664s left) gem_eio (wait-wedge-10ms)
[357.638054] Starting subtest: wait-wedge-10ms
[358.985547] Subtest wait-wedge-10ms: SUCCESS (1.347s)
[359.170973] [098/131] (662s left) core_setmaster_vs_auth
[359.390363] [099/131] (662s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[359.510685] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[368.537632] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (9.027s)
[369.368314] [100/131] (652s left) kms_flip (2x-absolute-wf_vblank)
[369.477081] Starting subtest: 2x-absolute-wf_vblank
[369.485973] Subtest 2x-absolute-wf_vblank: SKIP (0.010s)
[369.583622] [101/131] (652s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[369.676869] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[369.679044] Starting dynamic subtest: pipe-A-eDP-1
[369.698320] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.022s)
[369.708149] Starting dynamic subtest: pipe-B-eDP-1
[369.728490] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.021s)
[369.737407] Starting dynamic subtest: pipe-C-eDP-1
[369.757202] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.021s)
[369.765941] Starting dynamic subtest: pipe-D-eDP-1
[369.785226] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.021s)
[369.787478] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.090s)
[371.931193] [102/131] (649s left) i915_pm_rps (engine-order)
[371.999062] Starting subtest: engine-order
[376.904263] Subtest engine-order: SUCCESS (4.904s)
[377.076707] [103/131] (644s left) kms_rotation_crc (bad-pixel-format)
[377.183702] Starting subtest: bad-pixel-format
[377.187802] Subtest bad-pixel-format: SKIP (0.001s)
[377.283500] [104/131] (644s left) perf_pmu (module-unload)
[377.392659] Starting subtest: module-unload
[382.703807] Subtest module-unload: FAIL (5.211s)
[382.743647] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[382.745509] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[382.749769] [105/131] (639s left) gem_render_copy (y-tiled-to-vebox-linear)
[384.309200] Starting subtest: y-tiled-to-vebox-linear
[384.313756] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[384.469908] [FACT gem_render_copy (y-tiled-to-vebox-linear)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[384.471108] [FACT gem_render_copy (y-tiled-to-vebox-linear)] new: kernel.kmod_is_loaded.i915: true
[384.475118] [106/131] (637s left) gem_cs_tlb (engines)
[384.556684] Starting subtest: engines
[384.559049] Starting dynamic subtest: rcs0
[386.718445] Dynamic subtest rcs0: SUCCESS (2.157s)
[386.728862] Starting dynamic subtest: bcs0
[388.870517] Dynamic subtest bcs0: SUCCESS (2.151s)
[388.881249] Starting dynamic subtest: vcs0
[391.022713] Dynamic subtest vcs0: SUCCESS (2.151s)
[391.033547] Starting dynamic subtest: vcs1
[393.174768] Dynamic subtest vcs1: SUCCESS (2.151s)
[393.185742] Starting dynamic subtest: vecs0
[395.330121] Dynamic subtest vecs0: SUCCESS (2.154s)
[395.340863] Starting dynamic subtest: ccs0
[397.483039] Dynamic subtest ccs0: SUCCESS (2.151s)
[397.485462] Subtest engines: SUCCESS (12.921s)
[397.644821] [107/131] (624s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[397.763083] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[397.767429] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[397.880858] [108/131] (624s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[397.951481] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[397.953717] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[398.111479] [109/131] (624s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[398.205927] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[405.772072] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.570s)
[405.931626] [110/131] (616s left) kms_rotation_crc (exhaust-fences)
[406.025216] Starting subtest: exhaust-fences
[406.029161] Subtest exhaust-fences: SKIP (0.000s)
[406.120551] [111/131] (616s left) kms_atomic (plane-overlay-legacy)
[406.219217] Starting subtest: plane-overlay-legacy
[406.221474] Starting dynamic subtest: pipe-A-eDP-1
[406.642128] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.421s)
[406.644365] Subtest plane-overlay-legacy: SUCCESS (0.423s)
[407.509032] [112/131] (614s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[407.607475] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[407.609598] Starting dynamic subtest: pipe-A-eDP-1
[407.943793] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.307s)
[407.954671] Starting dynamic subtest: pipe-B-eDP-1
[409.206374] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.258s)
[409.214799] Starting dynamic subtest: pipe-C-eDP-1
[410.461918] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.256s)
[410.471071] Starting dynamic subtest: pipe-D-eDP-1
[411.682855] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.220s)
[411.685219] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (4.046s)
[412.854877] [113/131] (609s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[412.954476] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[412.958887] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[413.077622] [114/131] (609s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[413.472234] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[414.315588] [115/131] (608s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[414.415851] Starting subtest: fbc-psr2-sprite-plane-onoff
[414.418174] Starting dynamic subtest: eDP-1
[414.422266] Dynamic subtest eDP-1: SKIP (0.000s)
[414.426442] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s)
[414.514262] [116/131] (607s left) kms_psr (pr-primary-page-flip)
[414.614168] Starting subtest: pr-primary-page-flip
[414.618260] Subtest pr-primary-page-flip: SKIP (0.000s)
[414.714107] [117/131] (607s left) gem_exec_reloc (basic-wc-gtt)
[414.782878] Subtest basic-wc-gtt: SKIP (0.000s)
[414.861007] [118/131] (607s left) kms_plane_scaling (intel-max-src-size)
[414.963758] Starting subtest: intel-max-src-size
[414.970306] Subtest intel-max-src-size: SKIP (0.000s)
[415.094417] [119/131] (607s left) gem_eio (in-flight-1us)
[415.320583] Starting subtest: in-flight-1us
[423.830871] Subtest in-flight-1us: SUCCESS (8.510s)
[424.006705] [120/131] (598s left) kms_psr (fbc-pr-dpms)
[424.089084] Starting subtest: fbc-pr-dpms
[424.093076] Subtest fbc-pr-dpms: SKIP (0.000s)
[424.189290] [121/131] (598s left) gem_exec_schedule (noreorder)
[424.371497] Starting subtest: noreorder
[424.373778] Starting dynamic subtest: rcs0
[424.443973] Dynamic subtest rcs0: SUCCESS (0.075s)
[424.456486] Starting dynamic subtest: vcs0
[425.904032] Dynamic subtest vcs0: SUCCESS (1.457s)
[425.915048] Starting dynamic subtest: vcs1
[427.954482] Dynamic subtest vcs1: SUCCESS (2.047s)
[427.965984] Starting dynamic subtest: vecs0
[429.919370] Dynamic subtest vecs0: SUCCESS (1.962s)
[429.930419] Starting dynamic subtest: ccs0
[430.004360] Dynamic subtest ccs0: SUCCESS (0.084s)
[430.006852] Subtest noreorder: SUCCESS (5.637s)
[430.213460] [122/131] (592s left) gem_ccs (block-multicopy-inplace)
[430.273164] Starting subtest: block-multicopy-inplace
[430.277665] Subtest block-multicopy-inplace: SKIP (0.000s)
[430.431483] [123/131] (592s left) gem_exec_whisper (basic-queues-priority)
[430.491790] Starting subtest: basic-queues-priority
[454.912461] Subtest basic-queues-priority: SUCCESS (24.415s)
[455.129825] [124/131] (567s left) sw_sync (sync_merge)
[455.228325] Starting subtest: sync_merge
[455.230312] Subtest sync_merge: SUCCESS (0.000s)
[455.329070] [125/131] (567s left) kms_legacy_colorkey (invalid-plane)
[455.441612] Starting subtest: invalid-plane
[455.444639] Starting dynamic subtest: zero-id
[455.446580] Dynamic subtest zero-id: SUCCESS (0.000s)
[455.456723] Starting dynamic subtest: outrange-id
[455.459093] Dynamic subtest outrange-id: SUCCESS (0.000s)
[455.461417] Subtest invalid-plane: SUCCESS (0.001s)
[455.542518] [126/131] (567s left) kms_dirtyfb (default-dirtyfb-ioctl)
[455.642359] Starting subtest: default-dirtyfb-ioctl
[455.644587] Starting dynamic subtest: A-eDP-1
[457.285224] Dynamic subtest A-eDP-1: SUCCESS (1.641s)
[457.287733] Subtest default-dirtyfb-ioctl: SUCCESS (1.643s)
[458.109529] [127/131] (564s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[463.154959] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[463.159517] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.002s)
[464.051019] [128/131] (558s left) prime_mmap (test_map_unmap)
[464.113050] Starting subtest: test_map_unmap
[464.115228] Starting dynamic subtest: test_map_unmap-smem
[464.143659] Dynamic subtest test_map_unmap-smem: SUCCESS (0.032s)
[464.145984] Subtest test_map_unmap: SUCCESS (0.032s)
[464.286743] [129/131] (558s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[464.351459] Starting subtest: etime-multi-wait-all-for-submit-submitted
[464.457363] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.105s)
[464.564773] [130/131] (558s left) gem_userptr_blits (process-exit)
[464.633355] Starting subtest: process-exit
[464.639517] Subtest process-exit: SUCCESS (0.008s)
[464.798292] [131/131] (558s left) perf_pmu (busy-idle-check-all)
[464.841304] Starting subtest: busy-idle-check-all
[464.843336] Starting dynamic subtest: rcs0
[465.525807] Dynamic subtest rcs0: SUCCESS (0.687s)
[465.536883] Starting dynamic subtest: bcs0
[466.181495] Dynamic subtest bcs0: SUCCESS (0.654s)
[466.197088] Starting dynamic subtest: vcs0
[467.861072] Dynamic subtest vcs0: SUCCESS (1.676s)
[467.873280] Starting dynamic subtest: vcs1
[469.909355] Dynamic subtest vcs1: SUCCESS (2.046s)
[469.925519] Starting dynamic subtest: vecs0
[471.894463] Dynamic subtest vecs0: SUCCESS (1.984s)
[471.906279] Starting dynamic subtest: ccs0
[472.549073] Dynamic subtest ccs0: SUCCESS (0.653s)
[472.551589] Subtest busy-idle-check-all: SUCCESS (7.711s)
[472.671736] 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.