[59.496068] Initializing watchdogs
[59.496119]   /dev/watchdog0
[59.510546] [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]
[59.514980] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.517469] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.520864] [001/133] (960s left) kms_flip (basic-flip-vs-modeset)
[59.650977] Starting subtest: basic-flip-vs-modeset
[59.653441] Starting dynamic subtest: A-eDP1
[62.221512] Dynamic subtest A-eDP1: SUCCESS (2.569s)
[62.229368] Starting dynamic subtest: B-eDP1
[64.377693] Dynamic subtest B-eDP1: SUCCESS (2.158s)
[64.385734] Starting dynamic subtest: C-eDP1
[66.466047] Dynamic subtest C-eDP1: SUCCESS (2.088s)
[66.474318] Starting dynamic subtest: D-eDP1
[68.621432] Dynamic subtest D-eDP1: SUCCESS (2.153s)
[68.623904] Subtest basic-flip-vs-modeset: SUCCESS (8.974s)
[69.423905] [002/133] (950s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[69.806680] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[70.621744] [003/133] (949s left) gem_cs_tlb (engines)
[70.684076] Starting subtest: engines
[70.686458] Starting dynamic subtest: rcs0
[72.838441] Dynamic subtest rcs0: SUCCESS (2.151s)
[72.846768] Starting dynamic subtest: bcs0
[74.990688] Dynamic subtest bcs0: SUCCESS (2.150s)
[75.000640] Starting dynamic subtest: vcs0
[77.144064] Dynamic subtest vcs0: SUCCESS (2.152s)
[77.153893] Starting dynamic subtest: vcs1
[79.296039] Dynamic subtest vcs1: SUCCESS (2.152s)
[79.305744] Starting dynamic subtest: vecs0
[81.446572] Dynamic subtest vecs0: SUCCESS (2.151s)
[81.456362] Starting dynamic subtest: ccs0
[83.600184] Dynamic subtest ccs0: SUCCESS (2.154s)
[83.602217] Subtest engines: SUCCESS (12.913s)
[83.701175] [004/133] (936s left) kms_cursor_edge_walk (64x64-right-edge)
[83.800261] Starting subtest: 64x64-right-edge
[83.802590] Starting dynamic subtest: pipe-A-eDP-1
[87.313532] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.511s)
[87.322392] Starting dynamic subtest: pipe-D-eDP-1
[90.445889] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.130s)
[90.447915] Subtest 64x64-right-edge: SUCCESS (6.643s)
[91.239940] [005/133] (928s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[91.329671] Starting subtest: sprite-rotation-90-pos-100-0
[91.334634] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[91.399988] [006/133] (928s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[91.460464] Starting subtest: x-tiled-to-vebox-y-tiled
[91.464654] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[91.654853] [007/133] (928s left) gem_exec_schedule (implicit-write-read)
[91.721738] Starting subtest: implicit-write-read
[91.723684] Starting dynamic subtest: rcs0
[91.826408] Dynamic subtest rcs0: SUCCESS (0.114s)
[91.835785] Starting dynamic subtest: vcs0
[91.901375] Dynamic subtest vcs0: SUCCESS (0.074s)
[91.910672] Starting dynamic subtest: vcs1
[91.984050] Dynamic subtest vcs1: SUCCESS (0.083s)
[91.995383] Starting dynamic subtest: vecs0
[92.063037] Dynamic subtest vecs0: SUCCESS (0.079s)
[92.073374] Starting dynamic subtest: ccs0
[92.148068] Dynamic subtest ccs0: SUCCESS (0.085s)
[92.151072] Subtest implicit-write-read: SUCCESS (0.436s)
[92.983605] [008/133] (927s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[93.096666] Starting subtest: cursorB-vs-flipB-atomic
[93.100959] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[93.241886] [009/133] (927s left) syncobj_wait (wait-all-complex)
[93.298185] Starting subtest: wait-all-complex
[93.515600] Subtest wait-all-complex: SUCCESS (0.215s)
[93.586967] [010/133] (926s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[93.656044] Starting subtest: invalid-single-wait-all-unsubmitted
[93.658514] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[93.747609] [011/133] (926s left) prime_busy (hang-wait)
[93.802927] Starting subtest: hang-wait
[93.805318] Starting dynamic subtest: rcs0
[119.349509] Dynamic subtest rcs0: SUCCESS (25.543s)
[119.358501] Starting dynamic subtest: bcs0
[126.504315] Dynamic subtest bcs0: SUCCESS (7.155s)
[126.514026] Starting dynamic subtest: vcs0
[133.543037] Dynamic subtest vcs0: SUCCESS (7.037s)
[133.552239] Starting dynamic subtest: vcs1
[140.515245] Dynamic subtest vcs1: SUCCESS (6.971s)
[140.524412] Starting dynamic subtest: vecs0
[147.493054] Dynamic subtest vecs0: SUCCESS (6.976s)
[147.500428] Starting dynamic subtest: ccs0
[161.398501] Dynamic subtest ccs0: SUCCESS (13.905s)
[161.401415] Subtest hang-wait: SUCCESS (67.595s)
[161.513510] [012/133] (858s left) kms_psr (psr2-basic)
[161.618549] Starting subtest: psr2-basic
[161.620700] Starting dynamic subtest: eDP-1
[163.201067] Dynamic subtest eDP-1: SUCCESS (1.583s)
[163.203404] Subtest psr2-basic: SUCCESS (1.584s)
[164.009639] [013/133] (856s left) gem_exec_capture (userptr)
[164.063770] Starting subtest: userptr
[164.883125] Subtest userptr: SUCCESS (0.819s)
[165.014333] [014/133] (855s left) gem_gpgpu_fill (offset-16x16)
[165.076688] Starting subtest: offset-16x16
[165.084995] Subtest offset-16x16: SUCCESS (0.009s)
[165.200159] [015/133] (855s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc)
[165.294607] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs-cc
[165.296791] Starting dynamic subtest: pipe-A-eDP-1
[165.316957] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[165.324824] Starting dynamic subtest: pipe-B-eDP-1
[165.344735] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[165.352263] Starting dynamic subtest: pipe-C-eDP-1
[165.371670] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[165.380058] Starting dynamic subtest: pipe-D-eDP-1
[165.399580] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[165.401790] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.009s)
[167.561611] [016/133] (853s left) gem_exec_balancer (sequential)
[167.633795] Starting subtest: sequential
[170.717884] Subtest sequential: SUCCESS (3.086s)
[171.040097] [017/133] (849s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[171.145929] Starting subtest: y-tiled-64bpp-rotate-180
[171.150059] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[171.250956] [018/133] (849s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[171.344588] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[171.348621] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[171.452710] [019/133] (849s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[171.549694] Starting subtest: fbcpsr-suspend
[212.286038] Subtest fbcpsr-suspend: SUCCESS (10.253s)
[212.432227] [020/133] (808s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[212.544923] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[212.549158] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[212.636809] [021/133] (808s left) gem_exec_fence (submit)
[212.825943] Starting subtest: submit
[212.830801] Subtest submit: SKIP (0.000s)
[214.447527] [FACT gem_exec_fence (submit)] new: kernel.kmod_is_loaded.vgem: true
[214.451218] [022/133] (806s left) gem_exec_reloc (basic-wc-gtt)
[214.508344] Subtest basic-wc-gtt: SKIP (0.000s)
[214.573993] [023/133] (806s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[214.672970] Starting subtest: 4-tiled-64bpp-rotate-0
[216.186541] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.515s)
[216.392770] [024/133] (804s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[216.487467] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[216.491941] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[216.609890] [025/133] (804s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[216.697125] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[216.699052] Starting dynamic subtest: pipe-A-eDP-1
[217.996803] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.298s)
[218.010852] Starting dynamic subtest: pipe-B-eDP-1
[220.374342] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.375s)
[220.384674] Starting dynamic subtest: pipe-C-eDP-1
[222.726228] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.350s)
[222.736184] Starting dynamic subtest: pipe-D-eDP-1
[225.095235] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.367s)
[225.097627] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.396s)
[226.250893] [026/133] (794s left) gem_exec_reloc (basic-wc-active)
[226.308492] Subtest basic-wc-active: SKIP (0.000s)
[226.382450] [027/133] (794s left) gem_exec_balancer (individual)
[226.430712] Starting subtest: individual
[228.369025] Subtest individual: SUCCESS (1.935s)
[228.683286] [028/133] (792s left) kms_frontbuffer_tracking (fbc-tiling-4)
[228.789386] Starting subtest: fbc-tiling-4
[232.966846] Subtest fbc-tiling-4: SUCCESS (4.182s)
[234.149489] [029/133] (786s left) kms_lease (simple-lease)
[234.255462] Starting subtest: simple-lease
[234.257800] Starting dynamic subtest: pipe-A-eDP-1
[234.775263] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.518s)
[234.785815] Starting dynamic subtest: pipe-B-eDP-1
[236.186183] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.407s)
[236.196425] Starting dynamic subtest: pipe-C-eDP-1
[237.574075] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.387s)
[237.583308] Starting dynamic subtest: pipe-D-eDP-1
[238.982294] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.407s)
[238.984241] Subtest simple-lease: SUCCESS (4.725s)
[239.805615] [030/133] (781s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[239.878650] Starting subtest: yf-tiled-to-vebox-y-tiled
[239.883238] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[240.067928] [031/133] (781s left) kms_getfb (getfb-handle-valid)
[240.160227] Starting subtest: getfb-handle-valid
[240.162603] Subtest getfb-handle-valid: SUCCESS (0.000s)
[240.260252] [032/133] (780s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[240.644771] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[241.410680] [033/133] (779s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[241.513267] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[241.517524] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[241.618946] [034/133] (779s left) gem_exec_async (forked-writes)
[241.692569] Starting subtest: forked-writes
[241.695010] Starting dynamic subtest: rcs0
[241.721074] Dynamic subtest rcs0: SUCCESS (0.028s)
[241.734873] Starting dynamic subtest: bcs0
[241.746519] Dynamic subtest bcs0: SUCCESS (0.023s)
[241.755991] Starting dynamic subtest: vcs0
[241.769823] Dynamic subtest vcs0: SUCCESS (0.023s)
[241.779383] Starting dynamic subtest: vcs1
[241.793299] Dynamic subtest vcs1: SUCCESS (0.024s)
[241.802742] Starting dynamic subtest: vecs0
[241.817173] Dynamic subtest vecs0: SUCCESS (0.023s)
[241.826482] Starting dynamic subtest: ccs0
[241.838345] Dynamic subtest ccs0: SUCCESS (0.021s)
[241.840608] Subtest forked-writes: SUCCESS (0.146s)
[242.067732] [035/133] (779s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[242.165374] Starting subtest: psr-rgb565-draw-mmap-cpu
[249.026078] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.865s)
[249.154545] [036/133] (772s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[249.247176] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[253.468060] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.223s)
[254.670073] [037/133] (766s left) gem_close (many-handles-one-vma)
[254.726032] Starting subtest: many-handles-one-vma
[254.750468] Subtest many-handles-one-vma: SUCCESS (0.025s)
[254.839377] [038/133] (766s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[254.922575] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc
[254.924783] Starting dynamic subtest: pipe-A-eDP-1
[254.947249] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[254.957033] Starting dynamic subtest: pipe-B-eDP-1
[254.979108] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[254.987884] Starting dynamic subtest: pipe-C-eDP-1
[255.009699] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[255.018327] Starting dynamic subtest: pipe-D-eDP-1
[255.040667] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[255.044744] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[257.224616] [039/133] (764s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[257.324662] Starting subtest: x-tiled-16bpp-rotate-90
[257.343830] Subtest x-tiled-16bpp-rotate-90: SKIP (0.019s)
[257.446615] [040/133] (764s left) gem_mmap_gtt (basic-copy)
[257.507016] Subtest basic-copy: SKIP (0.000s)
[257.563550] [041/133] (764s left) kms_rmfb (rmfb-ioctl)
[257.657749] Starting subtest: rmfb-ioctl
[257.660044] Starting dynamic subtest: pipe-A-eDP-1
[257.762440] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.105s)
[257.775619] Starting dynamic subtest: pipe-B-eDP-1
[258.995475] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.231s)
[259.005042] Starting dynamic subtest: pipe-C-eDP-1
[260.114357] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.118s)
[260.124227] Starting dynamic subtest: pipe-D-eDP-1
[261.247270] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.131s)
[261.249538] Subtest rmfb-ioctl: SUCCESS (3.591s)
[262.471710] [042/133] (759s left) kms_color (ctm-negative)
[262.562145] Starting subtest: ctm-negative
[262.564025] Starting dynamic subtest: pipe-A-eDP-1
[263.283483] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.723s)
[263.295905] Starting dynamic subtest: pipe-B-eDP-1
[264.686632] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.400s)
[264.696398] Starting dynamic subtest: pipe-C-eDP-1
[266.056086] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.368s)
[266.065699] Starting dynamic subtest: pipe-D-eDP-1
[267.389935] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.335s)
[267.392210] Subtest ctm-negative: SUCCESS (4.829s)
[268.198268] [043/133] (753s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[268.294508] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[268.303674] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.010s)
[268.399597] [044/133] (753s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[268.496591] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[268.501041] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[268.587654] [045/133] (753s left) kms_big_fb (linear-8bpp-rotate-180)
[268.706061] Starting subtest: linear-8bpp-rotate-180
[269.964361] Subtest linear-8bpp-rotate-180: SUCCESS (1.258s)
[270.086479] [046/133] (751s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[270.184338] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[270.185954] Starting dynamic subtest: pipe-A-eDP-1
[271.060551] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.869s)
[271.070256] Starting dynamic subtest: pipe-B-eDP-1
[272.787861] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.723s)
[272.797900] Starting dynamic subtest: pipe-C-eDP-1
[274.316438] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.529s)
[274.326725] Starting dynamic subtest: pipe-D-eDP-1
[275.873659] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.554s)
[275.875906] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.680s)
[277.037065] [047/133] (744s left) gem_spin_batch (engines)
[277.111089] Starting subtest: engines
[277.113570] Starting dynamic subtest: rcs0
[280.354648] Dynamic subtest rcs0: SUCCESS (3.237s)
[280.365362] Starting dynamic subtest: bcs0
[283.683654] Dynamic subtest bcs0: SUCCESS (3.326s)
[283.694351] Starting dynamic subtest: vcs0
[286.920117] Dynamic subtest vcs0: SUCCESS (3.233s)
[286.930537] Starting dynamic subtest: vcs1
[290.157302] Dynamic subtest vcs1: SUCCESS (3.234s)
[290.172654] Starting dynamic subtest: vecs0
[293.487953] Dynamic subtest vecs0: SUCCESS (3.327s)
[293.498778] Starting dynamic subtest: ccs0
[296.724844] Dynamic subtest ccs0: SUCCESS (3.234s)
[296.727221] Subtest engines: SUCCESS (19.608s)
[296.954130] [048/133] (724s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[297.010281] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[297.119037] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.108s)
[297.198418] [049/133] (724s left) syncobj_eventfd (invalid-illegal-eventfd)
[297.252024] Starting subtest: invalid-illegal-eventfd
[297.254292] Subtest invalid-illegal-eventfd: SUCCESS (0.000s)
[297.344546] [050/133] (724s left) perf_pmu (most-busy-check-all)
[297.398590] Starting subtest: most-busy-check-all
[297.400804] Starting dynamic subtest: rcs0
[299.371251] Dynamic subtest rcs0: SUCCESS (1.972s)
[299.383953] Starting dynamic subtest: bcs0
[301.418545] Dynamic subtest bcs0: SUCCESS (2.044s)
[301.430779] Starting dynamic subtest: vcs0
[303.403235] Dynamic subtest vcs0: SUCCESS (1.981s)
[303.415521] Starting dynamic subtest: vcs1
[305.387029] Dynamic subtest vcs1: SUCCESS (1.981s)
[305.399559] Starting dynamic subtest: vecs0
[307.371446] Dynamic subtest vecs0: SUCCESS (1.981s)
[307.382590] Starting dynamic subtest: ccs0
[309.419564] Dynamic subtest ccs0: SUCCESS (2.045s)
[309.422392] Subtest most-busy-check-all: SUCCESS (12.022s)
[309.528989] [051/133] (712s left) gem_lmem_swapping (parallel-random-verify-ccs)
[309.572634] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[309.618447] [052/133] (712s left) kms_cursor_crc (cursor-size-change)
[309.708010] Starting subtest: cursor-size-change
[309.709899] Starting dynamic subtest: pipe-A-eDP-1
[310.510925] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.803s)
[310.519966] Starting dynamic subtest: pipe-D-eDP-1
[311.979243] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.468s)
[311.981463] Subtest cursor-size-change: SUCCESS (2.273s)
[312.797800] [053/133] (709s left) kms_selftest (drm_format)
[312.843417] Starting subtest: drm_format
[312.877228] Starting dynamic subtest: drm_test_format_block_width_invalid
[312.973145] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.096s)
[312.983201] Starting dynamic subtest: drm_test_format_block_width_one_plane
[313.057192] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.083s)
[313.068025] Starting dynamic subtest: drm_test_format_block_width_two_plane
[313.142231] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.085s)
[313.152472] Starting dynamic subtest: drm_test_format_block_width_three_plane
[313.220038] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.077s)
[313.229747] Starting dynamic subtest: drm_test_format_block_width_tiled
[313.308440] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.088s)
[313.318788] Starting dynamic subtest: drm_test_format_block_height_invalid
[313.398367] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.089s)
[313.408405] Starting dynamic subtest: drm_test_format_block_height_one_plane
[313.501354] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.102s)
[313.511732] Starting dynamic subtest: drm_test_format_block_height_two_plane
[313.599393] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.097s)
[313.609735] Starting dynamic subtest: drm_test_format_block_height_three_plane
[313.695312] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.095s)
[313.705011] Starting dynamic subtest: drm_test_format_block_height_tiled
[313.801679] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.106s)
[313.811603] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[313.895876] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.094s)
[313.905695] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[313.996265] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.100s)
[314.004549] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[314.107659] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.110s)
[314.115886] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[314.201734] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.094s)
[314.210085] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[314.305036] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.103s)
[314.313070] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[314.398369] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.092s)
[314.406500] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[314.492884] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.093s)
[314.501139] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[314.593904] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.101s)
[314.596047] Subtest drm_format: SUCCESS (1.752s)
[314.748354] [054/133] (707s left) kms_atomic_transition (plane-all-modeset-transition)
[314.840099] Starting subtest: plane-all-modeset-transition
[314.843851] Subtest plane-all-modeset-transition: SKIP (0.000s)
[314.915174] [055/133] (707s left) gem_exec_suspend (basic-s0)
[314.972606] Starting subtest: basic-S0
[314.974641] Starting dynamic subtest: smem
[335.589666] Dynamic subtest smem: SUCCESS (6.410s)
[335.592430] Subtest basic-S0: SUCCESS (6.412s)
[335.781096] [056/133] (686s left) gem_eio (in-flight-external)
[336.042870] Starting subtest: in-flight-external
[337.668834] Subtest in-flight-external: SUCCESS (1.624s)
[337.812001] [057/133] (684s left) kms_plane (pixel-format-yf-tiled-modifier)
[337.905541] Starting subtest: pixel-format-yf-tiled-modifier
[337.909884] Subtest pixel-format-yf-tiled-modifier: SKIP (0.000s)
[337.989956] [058/133] (684s left) core_getclient (basic)
[338.047089] Starting subtest: basic
[338.049418] Subtest basic: SUCCESS (0.000s)
[338.150809] [059/133] (684s left) kms_prop_blob (invalid-get-prop-any)
[338.204329] Starting subtest: invalid-get-prop-any
[338.206168] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[338.304482] [060/133] (684s left) kms_cursor_legacy (torture-bo)
[338.412020] Starting subtest: torture-bo
[338.413854] Starting dynamic subtest: pipe-A
[344.317341] Dynamic subtest pipe-A: SUCCESS (5.898s)
[344.331428] Starting dynamic subtest: pipe-B
[350.905211] Dynamic subtest pipe-B: SUCCESS (6.584s)
[350.918231] Starting dynamic subtest: pipe-C
[357.836504] Dynamic subtest pipe-C: SUCCESS (6.927s)
[357.852936] Starting dynamic subtest: pipe-D
[364.933887] Dynamic subtest pipe-D: SUCCESS (7.091s)
[364.951089] Starting dynamic subtest: all-pipes
[371.470959] Dynamic subtest all-pipes: SUCCESS (6.537s)
[371.473891] Subtest torture-bo: SUCCESS (33.048s)
[371.628789] [061/133] (650s left) kms_psr (psr-sprite-mmap-cpu)
[371.741197] Starting subtest: psr-sprite-mmap-cpu
[371.743326] Starting dynamic subtest: eDP-1
[373.453465] Dynamic subtest eDP-1: SUCCESS (1.712s)
[373.455783] Subtest psr-sprite-mmap-cpu: SUCCESS (1.713s)
[374.294139] [062/133] (648s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[374.393008] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[374.397108] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.000s)
[374.465359] [063/133] (648s left) i915_pm_freq_mult (media-freq)
[374.524164] Starting subtest: media-freq
[374.526410] Starting dynamic subtest: gt0
[374.530828] Dynamic subtest gt0: SKIP (0.000s)
[374.541380] Starting dynamic subtest: gt1
[374.545783] Dynamic subtest gt1: SKIP (0.000s)
[374.550013] Subtest media-freq: SKIP (0.001s)
[374.628842] [064/133] (647s left) kms_content_protection (lic-type-0)
[374.760646] Starting subtest: lic-type-0
[374.765054] Subtest lic-type-0: SKIP (0.000s)
[374.888761] [065/133] (647s left) perf (non-sampling-read-error)
[375.015591] Starting subtest: non-sampling-read-error
[375.024436] Subtest non-sampling-read-error: SUCCESS (0.009s)
[375.074296] [066/133] (647s left) gem_mmap (basic)
[375.135203] Subtest basic: SKIP (0.000s)
[375.208396] [067/133] (647s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[375.298997] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[375.302462] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.000s)
[375.370609] [068/133] (647s left) kms_psr (fbc-psr2-primary-render)
[375.462763] Starting subtest: fbc-psr2-primary-render
[375.464553] Starting dynamic subtest: eDP-1
[375.467950] Dynamic subtest eDP-1: SKIP (0.000s)
[375.471377] Subtest fbc-psr2-primary-render: SKIP (0.001s)
[375.538810] [069/133] (647s left) kms_psr (psr2-sprite-mmap-gtt)
[375.629502] Starting subtest: psr2-sprite-mmap-gtt
[375.631487] Starting dynamic subtest: eDP-1
[377.090863] Dynamic subtest eDP-1: SKIP (1.459s)
[377.096091] Subtest psr2-sprite-mmap-gtt: SKIP (1.461s)
[377.236808] [070/133] (645s left) gem_mmap_offset (perf)
[377.287593] Starting subtest: perf
[377.289454] Starting dynamic subtest: smem0
[377.642063] Dynamic subtest smem0: SUCCESS (0.353s)
[377.644476] Subtest perf: SUCCESS (0.354s)
[377.743332] [071/133] (645s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[377.835695] Starting subtest: bad-pixel-format-y-tiled-ccs
[377.837984] Starting dynamic subtest: pipe-A-eDP-1
[377.861097] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[377.872653] Starting dynamic subtest: pipe-B-eDP-1
[377.894443] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[377.903115] Starting dynamic subtest: pipe-C-eDP-1
[377.925192] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[377.934174] Starting dynamic subtest: pipe-D-eDP-1
[377.955654] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[377.959881] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.005s)
[380.077308] [072/133] (642s left) kms_feature_discovery (display-1x)
[380.164681] Starting subtest: display-1x
[380.166915] Subtest display-1x: SUCCESS (0.000s)
[380.240859] [073/133] (642s left) gem_ctx_persistence (legacy-engines-queued)
[380.298941] Starting subtest: legacy-engines-queued
[380.301292] Starting dynamic subtest: render
[380.366950] Dynamic subtest render: SUCCESS (0.068s)
[380.377127] Starting dynamic subtest: bsd1
[381.572666] Dynamic subtest bsd1: SUCCESS (1.202s)
[381.584950] Starting dynamic subtest: bsd2
[383.556255] Dynamic subtest bsd2: SUCCESS (1.979s)
[383.568803] Starting dynamic subtest: blt
[383.587529] Dynamic subtest blt: SUCCESS (0.030s)
[383.596651] Starting dynamic subtest: vebox
[385.539844] Dynamic subtest vebox: SUCCESS (1.949s)
[385.542516] Subtest legacy-engines-queued: SUCCESS (5.241s)
[385.620819] [074/133] (637s left) gem_exec_schedule (submit-late-slice)
[385.682851] Starting subtest: submit-late-slice
[385.685062] Starting dynamic subtest: rcs0
[385.739572] Dynamic subtest rcs0: SUCCESS (0.063s)
[385.755879] Starting dynamic subtest: bcs0
[385.801252] Dynamic subtest bcs0: SUCCESS (0.060s)
[385.816120] Starting dynamic subtest: vcs0
[385.862464] Dynamic subtest vcs0: SUCCESS (0.061s)
[385.873301] Starting dynamic subtest: vcs1
[385.919455] Dynamic subtest vcs1: SUCCESS (0.056s)
[385.932621] Starting dynamic subtest: vecs0
[385.968963] Dynamic subtest vecs0: SUCCESS (0.047s)
[385.978141] Starting dynamic subtest: ccs0
[386.026667] Dynamic subtest ccs0: SUCCESS (0.056s)
[386.029304] Subtest submit-late-slice: SUCCESS (0.352s)
[387.703921] [075/133] (635s left) gem_exec_gttfill (engines)
[387.768750] Starting subtest: engines
[387.771219] Starting dynamic subtest: rcs0
[411.460489] Dynamic subtest rcs0: SUCCESS (23.688s)
[411.472926] Starting dynamic subtest: bcs0
[434.805238] Dynamic subtest bcs0: SUCCESS (23.341s)
[434.817315] Starting dynamic subtest: vcs0
[458.112021] Dynamic subtest vcs0: SUCCESS (23.306s)
[458.122477] Starting dynamic subtest: vcs1
[481.440202] Dynamic subtest vcs1: SUCCESS (23.324s)
[481.451860] Starting dynamic subtest: vecs0
[504.764577] Dynamic subtest vecs0: SUCCESS (23.319s)
[504.777281] Starting dynamic subtest: ccs0
[528.171539] Dynamic subtest ccs0: SUCCESS (23.401s)
[528.174381] Subtest engines: SUCCESS (140.392s)
[528.366723] [076/133] (494s left) kms_addfb_basic (bo-too-small)
[528.525912] Starting subtest: bo-too-small
[528.528300] Subtest bo-too-small: SUCCESS (0.000s)
[528.662533] [077/133] (494s left) gem_basic (bad-close)
[528.725298] Starting subtest: bad-close
[528.729816] Subtest bad-close: SUCCESS (0.000s)
[528.838319] [078/133] (494s left) kms_atomic_transition (modeset-transition-fencing)
[528.933609] Starting subtest: modeset-transition-fencing
[528.935550] Starting dynamic subtest: 1x-outputs
[539.822307] Dynamic subtest 1x-outputs: SUCCESS (10.885s)
[539.824668] Subtest modeset-transition-fencing: SUCCESS (10.888s)
[540.683645] [079/133] (482s left) gem_wait (write-wait)
[540.753141] Starting subtest: write-wait
[540.755296] Starting dynamic subtest: all-engines
[541.851079] Dynamic subtest all-engines: SUCCESS (1.101s)
[541.871364] Starting dynamic subtest: rcs0
[542.913581] Dynamic subtest rcs0: SUCCESS (1.060s)
[542.929635] Starting dynamic subtest: bcs0
[543.974554] Dynamic subtest bcs0: SUCCESS (1.058s)
[543.992499] Starting dynamic subtest: vcs0
[545.031099] Dynamic subtest vcs0: SUCCESS (1.054s)
[545.048447] Starting dynamic subtest: vcs1
[546.084490] Dynamic subtest vcs1: SUCCESS (1.052s)
[546.101439] Starting dynamic subtest: vecs0
[547.137662] Dynamic subtest vecs0: SUCCESS (1.050s)
[547.154635] Starting dynamic subtest: ccs0
[548.194896] Dynamic subtest ccs0: SUCCESS (1.055s)
[548.197483] Subtest write-wait: SUCCESS (7.445s)
[548.394553] [080/133] (474s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[548.517273] Starting subtest: fbcpsr-rgb101010-draw-blt
[555.265923] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (6.748s)
[555.406671] [081/133] (467s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[555.511207] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[555.515505] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[555.620663] [082/133] (467s left) api_intel_allocator (open-vm)
[555.669933] Starting subtest: open-vm
[555.672178] Subtest open-vm: SUCCESS (0.003s)
[555.804772] [083/133] (467s left) kms_pm_rpm (system-suspend-idle)
[557.731078] Starting subtest: system-suspend-idle
[576.845844] Subtest system-suspend-idle: SUCCESS (4.287s)
[577.221689] [084/133] (446s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[577.295951] Starting subtest: invalid-bsd1-flag-on-blt
[577.298269] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[577.392710] [085/133] (446s left) core_hotunplug (unbind-rebind)
[577.509114] Starting subtest: unbind-rebind
[583.423253] Subtest unbind-rebind: SUCCESS (5.908s)
[583.463726] [086/133] (440s left) kms_getfb (getfb-handle-closed)
[585.436924] Starting subtest: getfb-handle-closed
[585.439248] Subtest getfb-handle-closed: SUCCESS (0.000s)
[585.545972] [087/133] (438s left) gem_mmap_gtt (basic-small-copy)
[585.616090] Subtest basic-small-copy: SKIP (0.000s)
[585.682940] [088/133] (437s left) gem_userptr_blits (forbidden-operations)
[585.745117] Starting subtest: forbidden-operations
[585.749371] Subtest forbidden-operations: SKIP (0.000s)
[585.877504] [089/133] (437s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[585.984044] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[585.988432] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[586.079298] [090/133] (437s left) kms_hdr (bpc-switch-dpms)
[586.171052] Starting subtest: bpc-switch-dpms
[587.296736] Starting dynamic subtest: pipe-A-eDP-1
[591.831787] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.531s)
[591.834123] Subtest bpc-switch-dpms: SUCCESS (5.659s)
[591.936074] [091/133] (431s left) perf (global-sseu-config)
[592.071928] Starting subtest: global-sseu-config
[592.076292] Subtest global-sseu-config: SKIP (0.000s)
[592.114727] [092/133] (431s left) kms_psr (fbc-psr-cursor-render)
[592.211487] Starting subtest: fbc-psr-cursor-render
[592.213606] Starting dynamic subtest: eDP-1
[592.217535] Dynamic subtest eDP-1: SKIP (0.000s)
[592.221470] Subtest fbc-psr-cursor-render: SKIP (0.001s)
[592.302510] [093/133] (431s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[592.418193] Starting subtest: flip-vs-cursor-atomic
[599.559323] Subtest flip-vs-cursor-atomic: SUCCESS (7.138s)
[600.416210] [094/133] (423s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[600.567646] Starting subtest: cursor-rapid-movement-32x10
[600.625003] Subtest cursor-rapid-movement-32x10: SKIP (0.051s)
[600.875964] [095/133] (423s left) gem_workarounds (basic-read-fd)
[600.934146] Starting subtest: basic-read-fd
[600.946908] Subtest basic-read-fd: SUCCESS (0.011s)
[601.074580] [096/133] (422s left) kms_plane_alpha_blend (alpha-7efc)
[601.175460] Starting subtest: alpha-7efc
[601.471210] Starting dynamic subtest: pipe-A-eDP-1
[602.091114] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.619s)
[602.130465] Starting dynamic subtest: pipe-D-eDP-1
[603.442730] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.320s)
[603.445038] Subtest alpha-7efc: SUCCESS (2.266s)
[604.302260] [097/133] (419s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[604.422541] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[604.427268] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[604.527004] [098/133] (419s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[604.631047] Starting subtest: fbc-rgb565-draw-mmap-cpu
[608.770515] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (4.141s)
[609.910235] [099/133] (414s left) kms_plane (plane-position-covered)
[609.999714] Starting subtest: plane-position-covered
[610.531432] Starting dynamic subtest: pipe-A-plane-1
[611.790378] Dynamic subtest pipe-A-plane-1: SUCCESS (1.258s)
[611.801226] Starting dynamic subtest: pipe-A-plane-2
[613.032503] Dynamic subtest pipe-A-plane-2: SUCCESS (1.241s)
[613.042729] Starting dynamic subtest: pipe-A-plane-3
[614.302421] Dynamic subtest pipe-A-plane-3: SUCCESS (1.269s)
[614.313553] Starting dynamic subtest: pipe-A-plane-4
[615.616224] Dynamic subtest pipe-A-plane-4: SUCCESS (1.314s)
[615.627079] Starting dynamic subtest: pipe-A-plane-5
[615.642020] Dynamic subtest pipe-A-plane-5: SUCCESS (0.023s)
[616.865484] Starting dynamic subtest: pipe-B-plane-1
[618.197318] Dynamic subtest pipe-B-plane-1: SUCCESS (1.341s)
[618.208590] Starting dynamic subtest: pipe-B-plane-2
[619.524463] Dynamic subtest pipe-B-plane-2: SUCCESS (1.327s)
[619.535920] Starting dynamic subtest: pipe-B-plane-3
[620.769947] Dynamic subtest pipe-B-plane-3: SUCCESS (1.246s)
[620.779950] Starting dynamic subtest: pipe-B-plane-4
[622.105827] Dynamic subtest pipe-B-plane-4: SUCCESS (1.335s)
[622.116805] Starting dynamic subtest: pipe-B-plane-5
[622.131982] Dynamic subtest pipe-B-plane-5: SUCCESS (0.023s)
[622.134386] Subtest plane-position-covered: SUCCESS (12.134s)
[622.980056] [100/133] (401s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[623.075061] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[623.086052] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.010s)
[623.166638] [101/133] (401s left) i915_hangman (error-state-basic)
[623.223451] Starting subtest: error-state-basic
[623.361373] Subtest error-state-basic: SUCCESS (0.138s)
[623.438455] [102/133] (400s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[623.532639] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[623.534974] Starting dynamic subtest: pipe-A
[623.554575] Dynamic subtest pipe-A: SKIP (0.017s)
[623.567936] Starting dynamic subtest: pipe-B
[623.586010] Dynamic subtest pipe-B: SKIP (0.033s)
[623.598922] Starting dynamic subtest: pipe-C
[623.625449] Dynamic subtest pipe-C: SKIP (0.037s)
[623.635736] Starting dynamic subtest: pipe-D
[623.659046] Dynamic subtest pipe-D: SKIP (0.032s)
[623.663500] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.122s)
[623.751020] [103/133] (400s left) sw_sync (sync_random_merge)
[623.791185] Starting subtest: sync_random_merge
[623.833828] Subtest sync_random_merge: SUCCESS (0.043s)
[623.899688] [104/133] (400s left) vgem_basic (bad-pad)
[623.938181] Starting subtest: bad-pad
[623.939915] Subtest bad-pad: SUCCESS (0.000s)
[623.994333] [105/133] (400s left) gen9_exec_parse (bb-start-out)
[624.050969] Subtest bb-start-out: SKIP (0.000s)
[624.109690] [106/133] (400s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[624.209567] Starting subtest: yf-tiled-16bpp-rotate-270
[624.213299] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[624.306540] [107/133] (400s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[624.401769] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[624.403405] Starting dynamic subtest: pipe-A-eDP-1
[624.885380] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.460s)
[624.896262] Starting dynamic subtest: pipe-B-eDP-1
[626.371604] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.478s)
[626.384023] Starting dynamic subtest: pipe-C-eDP-1
[627.795316] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.424s)
[627.807308] Starting dynamic subtest: pipe-D-eDP-1
[629.128109] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.330s)
[629.130062] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.697s)
[630.310429] [108/133] (394s left) gem_pwrite (basic-self)
[630.362780] Subtest basic-self: SKIP (0.000s)
[630.434395] [109/133] (394s left) kms_joiner (basic-max-non-joiner)
[630.533733] Starting subtest: basic-max-non-joiner
[630.537869] Subtest basic-max-non-joiner: SKIP (0.000s)
[630.602578] [110/133] (393s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[630.689722] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[653.667691] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (22.976s)
[653.803722] [111/133] (370s left) gem_ctx_persistence (engines-mixed-process)
[653.870443] Starting subtest: engines-mixed-process
[653.872433] Starting dynamic subtest: rcs0
[655.374727] Dynamic subtest rcs0: SUCCESS (1.503s)
[655.386200] Starting dynamic subtest: bcs0
[657.407581] Dynamic subtest bcs0: SUCCESS (2.029s)
[657.419174] Starting dynamic subtest: vcs0
[659.389916] Dynamic subtest vcs0: SUCCESS (1.981s)
[659.400275] Starting dynamic subtest: vcs1
[661.405010] Dynamic subtest vcs1: SUCCESS (2.015s)
[661.415562] Starting dynamic subtest: vecs0
[663.381647] Dynamic subtest vecs0: SUCCESS (1.974s)
[663.396918] Starting dynamic subtest: ccs0
[665.451743] Dynamic subtest ccs0: SUCCESS (2.064s)
[665.454110] Subtest engines-mixed-process: SUCCESS (11.576s)
[665.539575] [112/133] (359s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[665.631443] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[665.722495] [113/133] (359s left) kms_plane_lowres (tiling-y)
[665.806917] Starting subtest: tiling-y
[665.810936] Subtest tiling-y: SKIP (0.000s)
[665.897350] [114/133] (358s left) syncobj_timeline (wait-all-delayed-signal)
[665.957781] Starting subtest: wait-all-delayed-signal
[666.056910] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[666.151027] [115/133] (358s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[666.266236] Starting subtest: psr2-cursor-plane-move-continuous-exceed-sf
[666.268490] Starting dynamic subtest: pipe-A-eDP-1
[676.942904] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.683s)
[676.955951] Starting dynamic subtest: pipe-B-eDP-1
[688.362351] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.419s)
[688.364644] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SUCCESS (22.105s)
[689.216296] [116/133] (335s left) gem_ccs (ctrl-surf-copy-new-ctx)
[689.273254] Starting subtest: ctrl-surf-copy-new-ctx
[689.277336] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[689.367604] [117/133] (335s left) kms_cursor_crc (cursor-alpha-transparent)
[689.468562] Starting subtest: cursor-alpha-transparent
[689.470904] Starting dynamic subtest: pipe-A-eDP-1
[690.096952] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.629s)
[690.107975] Starting dynamic subtest: pipe-D-eDP-1
[691.400411] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.299s)
[691.402721] Subtest cursor-alpha-transparent: SUCCESS (1.931s)
[692.205704] [118/133] (332s left) gem_render_copy_redux (flink-interruptible)
[692.264441] Starting subtest: flink-interruptible
[693.119214] Subtest flink-interruptible: SUCCESS (0.855s)
[693.233089] [119/133] (331s left) i915_pm_rps (thresholds)
[693.286248] Starting subtest: thresholds
[693.290416] Subtest thresholds: SKIP (0.001s)
[693.404304] [120/133] (331s left) gem_tiled_partial_pwrite_pread (writes)
[693.454127] Subtest writes: SKIP (0.000s)
[693.516785] [121/133] (331s left) gem_basic (create-close)
[693.584071] Starting subtest: create-close
[693.587474] Subtest create-close: SUCCESS (0.000s)
[693.685923] [122/133] (331s left) i915_drm_fdinfo (busy-idle-check-all)
[693.725764] Starting subtest: busy-idle-check-all
[693.728082] Starting dynamic subtest: rcs0
[693.732208] Dynamic subtest rcs0: SKIP (0.003s)
[693.743661] Starting dynamic subtest: bcs0
[693.747179] Dynamic subtest bcs0: SKIP (0.000s)
[693.756997] Starting dynamic subtest: vcs0
[693.760665] Dynamic subtest vcs0: SKIP (0.000s)
[693.770899] Starting dynamic subtest: vcs1
[693.774469] Dynamic subtest vcs1: SKIP (0.000s)
[693.783856] Starting dynamic subtest: vecs0
[693.787420] Dynamic subtest vecs0: SKIP (0.000s)
[693.796828] Starting dynamic subtest: ccs0
[693.800379] Dynamic subtest ccs0: SKIP (0.001s)
[693.803892] Subtest busy-idle-check-all: SKIP (0.009s)
[693.840188] [123/133] (331s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[693.958012] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[701.523523] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.567s)
[701.674461] [124/133] (323s left) kms_pm_dc (dc6-psr)
[702.772943] Starting subtest: dc6-psr
[705.664031] Subtest dc6-psr: SUCCESS (2.891s)
[706.470474] [125/133] (318s left) kms_pipe_crc_basic (bad-source)
[706.566154] Starting subtest: bad-source
[706.567966] Subtest bad-source: SUCCESS (0.000s)
[706.640336] [126/133] (318s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[706.729480] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[706.733617] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[706.840172] [127/133] (318s left) syncobj_timeline (multi-wait-submitted-signaled)
[706.896139] Starting subtest: multi-wait-submitted-signaled
[706.898324] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[706.978457] [128/133] (318s left) kms_vblank (ts-continuation-suspend)
[707.075930] Starting subtest: ts-continuation-suspend
[707.078201] Starting dynamic subtest: pipe-A-eDP-1
[723.922954] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.533s)
[723.940148] Starting dynamic subtest: pipe-D-eDP-1
[740.920927] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.144s)
[740.923335] Subtest ts-continuation-suspend: SUCCESS (3.681s)
[741.732841] [129/133] (283s left) kms_psr (fbc-pr-primary-blt)
[741.831650] Starting subtest: fbc-pr-primary-blt
[741.835580] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[741.907267] [130/133] (283s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[742.002014] Starting subtest: fbc-2p-pri-indfb-multidraw
[742.006385] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[742.114232] [131/133] (283s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[742.225397] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[742.229806] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[742.340349] [132/133] (283s left) kms_flip (2x-flip-vs-panning)
[742.428855] Starting subtest: 2x-flip-vs-panning
[742.438025] Subtest 2x-flip-vs-panning: SKIP (0.011s)
[742.528921] [133/133] (283s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[742.582517] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[742.635104] Closing watchdogs
results: parsing output: 0/ for test: kms_flip
results: parsing output: 1/ for test: kms_chamelium_hpd
results: parsing output: 2/ for test: gem_cs_tlb
results: parsing output: 3/ for test: kms_cursor_edge_walk
results: parsing output: 4/ for test: kms_rotation_crc
results: parsing output: 5/ for test: gem_render_copy
results: parsing output: 6/ for test: gem_exec_schedule
results: parsing output: 7/ for test: kms_cursor_legacy
results: parsing output: 8/ for test: syncobj_wait
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: prime_busy
results: parsing output: 11/ for test: kms_psr
results: parsing output: 12/ for test: gem_exec_capture
results: parsing output: 13/ for test: gem_gpgpu_fill
results: parsing output: 14/ for test: kms_ccs
results: parsing output: 15/ for test: gem_exec_balancer
results: parsing output: 16/ for test: kms_big_fb
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: gem_exec_fence
results: parsing output: 21/ for test: gem_exec_reloc
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: gem_exec_reloc
results: parsing output: 26/ for test: gem_exec_balancer
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_lease
results: parsing output: 29/ for test: gem_render_copy
results: parsing output: 30/ for test: kms_getfb
results: parsing output: 31/ for test: kms_chamelium_edid
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: gem_exec_async
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: gem_close
results: parsing output: 37/ for test: kms_ccs
results: parsing output: 38/ for test: kms_big_fb
results: parsing output: 39/ for test: gem_mmap_gtt
results: parsing output: 40/ for test: kms_rmfb
results: parsing output: 41/ for test: kms_color
results: parsing output: 42/ for test: kms_flip
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: kms_ccs
results: parsing output: 46/ for test: gem_spin_batch
results: parsing output: 47/ for test: syncobj_timeline
results: parsing output: 48/ for test: syncobj_eventfd
results: parsing output: 49/ for test: perf_pmu
results: parsing output: 50/ for test: gem_lmem_swapping
results: parsing output: 51/ for test: kms_cursor_crc
results: parsing output: 52/ for test: kms_selftest
results: parsing output: 53/ for test: kms_atomic_transition
results: parsing output: 54/ for test: gem_exec_suspend
results: parsing output: 55/ for test: gem_eio
results: parsing output: 56/ for test: kms_plane
results: parsing output: 57/ for test: core_getclient
results: parsing output: 58/ for test: kms_prop_blob
results: parsing output: 59/ for test: kms_cursor_legacy
results: parsing output: 60/ for test: kms_psr
results: parsing output: 61/ for test: kms_flip_scaled_crc
results: parsing output: 62/ for test: i915_pm_freq_mult
results: parsing output: 63/ for test: kms_content_protection
results: parsing output: 64/ for test: perf
results: parsing output: 65/ for test: gem_mmap
results: parsing output: 66/ for test: kms_flip_scaled_crc
results: parsing output: 67/ for test: kms_psr
results: parsing output: 68/ for test: kms_psr
results: parsing output: 69/ for test: gem_mmap_offset
results: parsing output: 70/ for test: kms_ccs
results: parsing output: 71/ for test: kms_feature_discovery
results: parsing output: 72/ for test: gem_ctx_persistence
results: parsing output: 73/ for test: gem_exec_schedule
results: parsing output: 74/ for test: gem_exec_gttfill
results: parsing output: 75/ for test: kms_addfb_basic
results: parsing output: 76/ for test: gem_basic
results: parsing output: 77/ for test: kms_atomic_transition
results: parsing output: 78/ for test: gem_wait
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: api_intel_allocator
results: parsing output: 82/ for test: kms_pm_rpm
results: parsing output: 83/ for test: gem_exec_params
results: parsing output: 84/ for test: core_hotunplug
results: parsing output: 85/ for test: kms_getfb
results: parsing output: 86/ for test: gem_mmap_gtt
results: parsing output: 87/ for test: gem_userptr_blits
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_hdr
results: parsing output: 90/ for test: perf
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: kms_cursor_legacy
results: parsing output: 93/ for test: kms_cursor_crc
results: parsing output: 94/ for test: gem_workarounds
results: parsing output: 95/ for test: kms_plane_alpha_blend
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_plane
results: parsing output: 99/ for test: kms_flip
results: parsing output: 100/ for test: i915_hangman
results: parsing output: 101/ for test: kms_plane_scaling
results: parsing output: 102/ for test: sw_sync
results: parsing output: 103/ for test: vgem_basic
results: parsing output: 104/ for test: gen9_exec_parse
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: kms_ccs
results: parsing output: 107/ for test: gem_pwrite
results: parsing output: 108/ for test: kms_joiner
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: gem_ctx_persistence
results: parsing output: 111/ for test: kms_addfb_basic
results: parsing output: 112/ for test: kms_plane_lowres
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: kms_psr2_sf
results: parsing output: 115/ for test: gem_ccs
results: parsing output: 116/ for test: kms_cursor_crc
results: parsing output: 117/ for test: gem_render_copy_redux
results: parsing output: 118/ for test: i915_pm_rps
results: parsing output: 119/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 120/ for test: gem_basic
results: parsing output: 121/ for test: i915_drm_fdinfo
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_pm_dc
results: parsing output: 124/ for test: kms_pipe_crc_basic
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: syncobj_timeline
results: parsing output: 127/ for test: kms_vblank
results: parsing output: 128/ for test: kms_psr
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_big_fb
results: parsing output: 131/ for test: kms_flip
results: parsing output: 132/ for test: kms_pipe_b_c_ivb
Done.