[58.009782] Initializing watchdogs
[58.009846]   /dev/watchdog0
[58.029623] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[58.040702] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[58.044551] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.047080] [001/131] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[58.245746] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[58.247430] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[58.385957] [002/131] (960s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[58.580413] Starting subtest: 2x-absolute-wf_vblank-interruptible
[58.595718] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.014s)
[58.703605] [003/131] (959s left) kms_plane (plane-position-hole)
[58.893132] Starting subtest: plane-position-hole
[59.369494] Starting dynamic subtest: pipe-A-plane-1
[59.820783] Dynamic subtest pipe-A-plane-1: SUCCESS (0.452s)
[59.833019] Starting dynamic subtest: pipe-A-plane-2
[60.285211] Dynamic subtest pipe-A-plane-2: SUCCESS (0.465s)
[60.293012] Starting dynamic subtest: pipe-A-plane-3
[60.739140] Dynamic subtest pipe-A-plane-3: SUCCESS (0.456s)
[60.746958] Starting dynamic subtest: pipe-A-plane-4
[61.187163] Dynamic subtest pipe-A-plane-4: SUCCESS (0.448s)
[61.194939] Starting dynamic subtest: pipe-A-plane-5
[61.207262] Dynamic subtest pipe-A-plane-5: SUCCESS (0.019s)
[61.581120] Starting dynamic subtest: pipe-B-plane-1
[62.007160] Dynamic subtest pipe-B-plane-1: SUCCESS (0.435s)
[62.015266] Starting dynamic subtest: pipe-B-plane-2
[62.424016] Dynamic subtest pipe-B-plane-2: SUCCESS (0.418s)
[62.431782] Starting dynamic subtest: pipe-B-plane-3
[62.863447] Dynamic subtest pipe-B-plane-3: SUCCESS (0.439s)
[62.872194] Starting dynamic subtest: pipe-B-plane-4
[63.267745] Dynamic subtest pipe-B-plane-4: SUCCESS (0.405s)
[63.278359] Starting dynamic subtest: pipe-B-plane-5
[63.292912] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[63.293838] Subtest plane-position-hole: SUCCESS (4.407s)
[63.541895] [004/131] (955s left) kms_flip (nonblocking-read)
[63.733053] Starting subtest: nonblocking-read
[63.733956] Subtest nonblocking-read: SUCCESS (0.000s)
[63.859073] [005/131] (954s left) gem_tiled_pread_basic
[64.007591] [006/131] (954s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[64.211225] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[65.546717] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.336s)
[65.753832] [007/131] (953s left) kms_psr (fbc-psr-cursor-mmap-cpu)
[65.941230] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.000s)
[65.999221] [008/131] (952s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[66.188132] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[66.189055] Starting dynamic subtest: pipe-A-DP-3
[66.197517] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[66.205057] Starting dynamic subtest: pipe-B-DP-3
[66.213606] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[66.221064] Starting dynamic subtest: pipe-C-DP-3
[66.229258] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[66.236533] Starting dynamic subtest: pipe-D-DP-3
[66.245784] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[66.247971] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.004s)
[66.616962] [009/131] (952s left) kms_getfb (getfb2-accept-nv12)
[66.836466] Starting subtest: getfb2-accept-nv12
[66.838415] Subtest getfb2-accept-nv12: SUCCESS (0.002s)
[67.380567] [010/131] (951s left) kms_pm_rpm (cursor-dpms)
[69.053284] Starting subtest: cursor-dpms
[69.056654] Subtest cursor-dpms: SKIP (0.000s)
[69.418150] [011/131] (949s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[69.612703] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[69.614297] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[69.740170] [012/131] (949s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[69.999872] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[70.143695] [013/131] (949s left) gem_pread (self)
[70.218041] Subtest self: SKIP (0.000s)
[70.311816] [014/131] (949s left) gem_bad_reloc (negative-reloc-lut)
[70.393443] Subtest negative-reloc-lut: SKIP (0.000s)
[70.462142] [015/131] (948s left) sriov_basic (enable-vfs-autoprobe-on)
[70.531011] Subtest enable-vfs-autoprobe-on: SKIP (0.000s)
[70.601746] [016/131] (948s left) gem_ctx_param (invalid-get-ringsize)
[70.672385] Starting subtest: invalid-get-ringsize
[70.674321] Subtest invalid-get-ringsize: SUCCESS (0.002s)
[70.798880] [017/131] (948s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[70.868418] Starting subtest: multi-wait-all-for-submit-submitted
[70.971381] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.102s)
[71.081513] [018/131] (948s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[71.276112] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[71.277672] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[71.410497] [019/131] (948s left) kms_flip (modeset-vs-vblank-race-interruptible)
[71.603563] Starting subtest: modeset-vs-vblank-race-interruptible
[71.608077] Starting dynamic subtest: A-DP3
[74.890188] Dynamic subtest A-DP3: SUCCESS (3.282s)
[74.923437] Starting dynamic subtest: B-DP3
[77.988970] Dynamic subtest B-DP3: SUCCESS (3.097s)
[78.025345] Starting dynamic subtest: C-DP3
[81.061135] Dynamic subtest C-DP3: SUCCESS (3.069s)
[81.096745] Starting dynamic subtest: D-DP3
[84.187161] Dynamic subtest D-DP3: SUCCESS (3.122s)
[84.194742] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (12.592s)
[84.543281] [020/131] (935s left) kms_psr (fbc-psr-sprite-render)
[84.736156] Subtest fbc-psr-sprite-render: SKIP (0.000s)
[84.794477] [021/131] (934s left) gem_softpin (allocator-basic-reserve)
[84.868763] Starting subtest: allocator-basic-reserve
[85.100392] Subtest allocator-basic-reserve: SUCCESS (0.230s)
[85.263243] [022/131] (934s left) drm_read (invalid-buffer)
[85.523295] Starting subtest: invalid-buffer
[85.524238] Subtest invalid-buffer: SUCCESS (0.000s)
[85.771455] [023/131] (934s left) i915_drm_fdinfo (memory-info-shared)
[85.836595] Starting subtest: memory-info-shared
[85.837437] Starting dynamic subtest: lmem0
[85.914510] Dynamic subtest lmem0: SUCCESS (0.077s)
[85.922672] Starting dynamic subtest: smem0
[85.962510] Dynamic subtest smem0: SUCCESS (0.047s)
[85.963460] Subtest memory-info-shared: SUCCESS (0.126s)
[86.071014] [024/131] (933s left) i915_drm_fdinfo (busy-idle)
[86.133699] Starting subtest: busy-idle
[86.134578] Starting dynamic subtest: rcs0
[86.151190] Dynamic subtest rcs0: SKIP (0.016s)
[86.159532] Starting dynamic subtest: bcs0
[86.169222] Dynamic subtest bcs0: SKIP (0.017s)
[86.177845] Starting dynamic subtest: vcs0
[86.180167] Dynamic subtest vcs0: SKIP (0.000s)
[86.187984] Starting dynamic subtest: vcs1
[86.190164] Dynamic subtest vcs1: SKIP (0.000s)
[86.198170] Starting dynamic subtest: vecs0
[86.200565] Dynamic subtest vecs0: SKIP (0.000s)
[86.208666] Starting dynamic subtest: vecs1
[86.210969] Dynamic subtest vecs1: SKIP (0.000s)
[86.219072] Starting dynamic subtest: ccs0
[86.221166] Dynamic subtest ccs0: SKIP (0.000s)
[86.224495] Subtest busy-idle: SKIP (0.040s)
[86.265167] [025/131] (933s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[86.460143] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[86.461883] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[86.598641] [026/131] (933s left) kms_psr (psr2-sprite-plane-onoff)
[86.786188] Subtest psr2-sprite-plane-onoff: SKIP (0.000s)
[86.844990] [027/131] (933s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[87.032447] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[87.034507] Starting dynamic subtest: pipe-A-DP-3
[87.043040] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[87.050955] Starting dynamic subtest: pipe-B-DP-3
[87.059396] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[87.067112] Starting dynamic subtest: pipe-C-DP-3
[87.075432] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[87.083093] Starting dynamic subtest: pipe-D-DP-3
[87.093561] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[87.095541] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.006s)
[87.477190] [028/131] (932s left) kms_dp_link_training (uhbr-sst)
[87.663428] Starting subtest: uhbr-sst
[87.665270] Subtest uhbr-sst: SKIP (0.000s)
[87.778964] [029/131] (932s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[87.979594] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[88.026291] [030/131] (932s left) perf (blocking-parameterized)
[88.366455] Starting subtest: blocking-parameterized
[108.399632] Subtest blocking-parameterized: SUCCESS (20.033s)
[108.445518] [031/131] (911s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[108.635917] Starting subtest: cursorA-vs-flipB-legacy
[108.637986] Subtest cursorA-vs-flipB-legacy: SKIP (0.002s)
[108.760909] [032/131] (911s left) kms_color (deep-color)
[108.946375] Starting subtest: deep-color
[112.249600] Starting dynamic subtest: pipe-A-DP-3-gamma
[118.180920] Dynamic subtest pipe-A-DP-3-gamma: SUCCESS (5.932s)
[118.189781] Starting dynamic subtest: pipe-A-DP-3-degamma
[124.073307] Dynamic subtest pipe-A-DP-3-degamma: SUCCESS (5.891s)
[124.082432] Starting dynamic subtest: pipe-A-DP-3-ctm
[129.982404] Dynamic subtest pipe-A-DP-3-ctm: SUCCESS (5.908s)
[133.270107] Starting dynamic subtest: pipe-B-DP-3-gamma
[139.180560] Dynamic subtest pipe-B-DP-3-gamma: SUCCESS (5.921s)
[139.189930] Starting dynamic subtest: pipe-B-DP-3-degamma
[145.058045] Dynamic subtest pipe-B-DP-3-degamma: SUCCESS (5.876s)
[145.066237] Starting dynamic subtest: pipe-B-DP-3-ctm
[150.937673] Dynamic subtest pipe-B-DP-3-ctm: SUCCESS (5.878s)
[154.161166] Starting dynamic subtest: pipe-C-DP-3-gamma
[160.085426] Dynamic subtest pipe-C-DP-3-gamma: SUCCESS (5.937s)
[160.094472] Starting dynamic subtest: pipe-C-DP-3-degamma
[165.987739] Dynamic subtest pipe-C-DP-3-degamma: SUCCESS (5.901s)
[165.996683] Starting dynamic subtest: pipe-C-DP-3-ctm
[171.893068] Dynamic subtest pipe-C-DP-3-ctm: SUCCESS (5.903s)
[175.127613] Starting dynamic subtest: pipe-D-DP-3-gamma
[181.069471] Dynamic subtest pipe-D-DP-3-gamma: SUCCESS (5.955s)
[181.080896] Starting dynamic subtest: pipe-D-DP-3-degamma
[186.990579] Dynamic subtest pipe-D-DP-3-degamma: SUCCESS (5.919s)
[186.999696] Starting dynamic subtest: pipe-D-DP-3-ctm
[192.894441] Dynamic subtest pipe-D-DP-3-ctm: SUCCESS (5.903s)
[192.895743] Subtest deep-color: SUCCESS (83.947s)
[193.120043] [033/131] (827s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[193.194256] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[193.273121] [034/131] (827s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[193.460716] Starting subtest: async-flip-with-page-flip-events-linear
[193.691822] Starting dynamic subtest: pipe-A-DP-3
[195.962932] Dynamic subtest pipe-A-DP-3: SUCCESS (2.270s)
[196.173928] Starting dynamic subtest: pipe-B-DP-3
[198.267350] Dynamic subtest pipe-B-DP-3: SUCCESS (2.101s)
[198.490369] Starting dynamic subtest: pipe-C-DP-3
[200.581214] Dynamic subtest pipe-C-DP-3: SUCCESS (2.097s)
[200.803919] Starting dynamic subtest: pipe-D-DP-3
[202.887477] Dynamic subtest pipe-D-DP-3: SUCCESS (2.090s)
[202.893537] Subtest async-flip-with-page-flip-events-linear: SUCCESS (9.428s)
[203.342898] [035/131] (817s left) kms_lease (lessee-list)
[203.531505] Starting subtest: lessee-list
[203.533939] Starting dynamic subtest: pipe-A-DP-3
[203.536372] Dynamic subtest pipe-A-DP-3: SUCCESS (0.002s)
[203.544519] Starting dynamic subtest: pipe-B-DP-3
[203.545432] Dynamic subtest pipe-B-DP-3: SUCCESS (0.002s)
[203.553438] Starting dynamic subtest: pipe-C-DP-3
[203.554358] Dynamic subtest pipe-C-DP-3: SUCCESS (0.002s)
[203.562307] Starting dynamic subtest: pipe-D-DP-3
[203.563562] Dynamic subtest pipe-D-DP-3: SUCCESS (0.002s)
[203.564768] Subtest lessee-list: SUCCESS (0.014s)
[203.679674] [036/131] (816s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[203.877056] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[203.878806] Subtest psr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[204.019951] [037/131] (816s left) sysfs_timeslice_duration (timeout)
[204.095210] Starting subtest: timeout
[204.096203] Starting dynamic subtest: vecs0
[205.852296] Dynamic subtest vecs0: SUCCESS (1.756s)
[205.860775] Starting dynamic subtest: ccs0
[207.583395] Dynamic subtest ccs0: SUCCESS (1.730s)
[207.591658] Starting dynamic subtest: vcs0
[209.278134] Dynamic subtest vcs0: SUCCESS (1.694s)
[209.286483] Starting dynamic subtest: bcs0
[210.344121] Dynamic subtest bcs0: SUCCESS (1.065s)
[210.352404] Starting dynamic subtest: vecs1
[212.085159] Dynamic subtest vecs1: SUCCESS (1.740s)
[212.093514] Starting dynamic subtest: rcs0
[213.758043] Dynamic subtest rcs0: SUCCESS (1.672s)
[213.766448] Starting dynamic subtest: vcs1
[215.439325] Dynamic subtest vcs1: SUCCESS (1.680s)
[215.440209] Subtest timeout: SUCCESS (11.344s)
[215.560797] [038/131] (805s left) gem_userptr_blits (create-destroy-unsync)
[215.639958] Subtest create-destroy-unsync: SKIP (0.000s)
[215.790858] [039/131] (804s left) gem_mmap_gtt (ptrace)
[215.860234] Subtest ptrace: SKIP (0.000s)
[215.923205] [040/131] (804s left) syncobj_wait (wait-all-for-submit-complex)
[215.991499] Starting subtest: wait-all-for-submit-complex
[216.208482] Subtest wait-all-for-submit-complex: SUCCESS (0.217s)
[216.336452] [041/131] (804s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[216.528905] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[216.530588] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[216.640276] [042/131] (804s left) gem_exec_fence (syncobj-timeline-wait)
[217.339274] Starting subtest: syncobj-timeline-wait
[217.474783] Subtest syncobj-timeline-wait: SUCCESS (0.137s)
[217.758747] [FACT gem_exec_fence (syncobj-timeline-wait)] new: kernel.kmod_is_loaded.vgem: true
[217.760940] [043/131] (803s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[217.963960] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[217.965640] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[218.109716] [044/131] (802s left) syncobj_timeline (transfer-timeline-point)
[218.188511] Starting subtest: transfer-timeline-point
[218.189414] Subtest transfer-timeline-point: SUCCESS (0.001s)
[218.320914] [045/131] (802s left) gem_spin_batch (legacy)
[218.411199] Starting subtest: legacy
[218.413522] Starting dynamic subtest: default
[221.672613] Dynamic subtest default: SUCCESS (3.257s)
[221.687009] Starting dynamic subtest: render
[224.911585] Dynamic subtest render: SUCCESS (3.234s)
[224.929523] Starting dynamic subtest: bsd
[228.155049] Dynamic subtest bsd: SUCCESS (3.237s)
[228.165495] Starting dynamic subtest: bsd1
[231.389172] Dynamic subtest bsd1: SUCCESS (3.230s)
[231.403070] Starting dynamic subtest: bsd2
[234.626450] Dynamic subtest bsd2: SUCCESS (3.233s)
[234.643851] Starting dynamic subtest: blt
[237.868106] Dynamic subtest blt: SUCCESS (3.236s)
[237.879387] Starting dynamic subtest: vebox
[241.102601] Dynamic subtest vebox: SUCCESS (3.230s)
[241.104264] Subtest legacy: SUCCESS (22.691s)
[241.363091] [046/131] (779s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[241.571428] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[241.573165] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[241.703895] [047/131] (779s left) api_intel_allocator (gem-pool)
[241.782753] Starting subtest: gem-pool
[241.817411] Subtest gem-pool: SUCCESS (0.036s)
[242.015033] [048/131] (779s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render)
[242.218973] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render
[242.220768] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[242.354803] [049/131] (779s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[242.562399] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[243.817106] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.254s)
[244.047554] [050/131] (777s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-blt)
[244.247141] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-blt
[246.554746] Subtest fbc-1p-offscren-pri-shrfb-draw-blt: SUCCESS (2.307s)
[246.721797] [051/131] (774s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[246.922211] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[246.923881] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[247.053899] [052/131] (774s left) kms_cursor_crc (cursor-sliding-512x512)
[247.523592] Starting subtest: cursor-sliding-512x512
[247.526751] Subtest cursor-sliding-512x512: SKIP (0.001s)
[247.789954] [053/131] (773s left) gem_request_retire (retire-vma-not-inactive)
[247.874167] Starting subtest: retire-vma-not-inactive
[247.958426] Subtest retire-vma-not-inactive: SUCCESS (0.083s)
[248.161593] [054/131] (773s left) gem_exec_schedule (noreorder)
[248.397670] Starting subtest: noreorder
[248.402093] Starting dynamic subtest: rcs0
[248.510378] Dynamic subtest rcs0: SUCCESS (0.111s)
[248.522271] Starting dynamic subtest: bcs0
[248.567394] Dynamic subtest bcs0: SUCCESS (0.056s)
[248.582964] Starting dynamic subtest: vcs0
[248.639416] Dynamic subtest vcs0: SUCCESS (0.070s)
[248.677389] Starting dynamic subtest: vcs1
[248.725649] Dynamic subtest vcs1: SUCCESS (0.082s)
[248.749423] Starting dynamic subtest: vecs0
[248.801100] Dynamic subtest vecs0: SUCCESS (0.073s)
[248.838341] Starting dynamic subtest: vecs1
[248.881219] Dynamic subtest vecs1: SUCCESS (0.077s)
[248.895300] Starting dynamic subtest: ccs0
[248.918290] Dynamic subtest ccs0: SUCCESS (0.036s)
[248.919286] Subtest noreorder: SUCCESS (0.522s)
[249.217765] [055/131] (772s left) gem_userptr_blits (coherency-sync)
[249.314456] Starting subtest: coherency-sync
[249.627268] Subtest coherency-sync: SKIP (0.297s)
[249.788563] [056/131] (772s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[250.042545] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[250.044994] Starting dynamic subtest: pipe-A-DP-3
[250.053453] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[250.062604] Starting dynamic subtest: pipe-B-DP-3
[250.071014] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[250.080027] Starting dynamic subtest: pipe-C-DP-3
[250.088115] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[250.097346] Starting dynamic subtest: pipe-D-DP-3
[250.107788] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[250.109891] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SKIP (0.007s)
[250.478615] [057/131] (771s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[250.682462] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[250.738795] [058/131] (771s left) kms_selftest (drm_dp_mst_helper)
[250.801368] Starting subtest: drm_dp_mst_helper
[250.818507] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[250.907211] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.088s)
[250.943189] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[251.022726] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.111s)
[251.061171] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[251.127271] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.101s)
[251.128618] Subtest drm_dp_mst_helper: SUCCESS (0.326s)
[251.343481] [059/131] (770s left) kms_vblank (query-idle-hang)
[251.537515] Starting subtest: query-idle-hang
[251.540008] Starting dynamic subtest: pipe-A-DP-3
[277.552966] Dynamic subtest pipe-A-DP-3: SUCCESS (26.013s)
[277.565490] Starting dynamic subtest: pipe-D-DP-3
[302.586111] Dynamic subtest pipe-D-DP-3: SUCCESS (25.029s)
[302.589721] Subtest query-idle-hang: SUCCESS (51.049s)
[302.859027] [060/131] (719s left) kms_hdr (invalid-metadata-sizes)
[303.061574] Starting subtest: invalid-metadata-sizes
[306.371230] Starting dynamic subtest: pipe-A-DP-3
[306.372301] Dynamic subtest pipe-A-DP-3: SUCCESS (0.001s)
[306.373357] Subtest invalid-metadata-sizes: SUCCESS (3.311s)
[306.630842] [061/131] (715s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[306.831994] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[306.833756] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[306.975355] [062/131] (715s left) gem_exec_schedule (preempt-other)
[307.073311] Starting subtest: preempt-other
[307.074499] Starting dynamic subtest: rcs0
[307.630321] Dynamic subtest rcs0: SUCCESS (0.556s)
[307.639687] Starting dynamic subtest: bcs0
[308.162974] Dynamic subtest bcs0: SUCCESS (0.532s)
[308.172347] Starting dynamic subtest: vcs0
[308.686463] Dynamic subtest vcs0: SUCCESS (0.522s)
[308.695668] Starting dynamic subtest: vcs1
[309.238426] Dynamic subtest vcs1: SUCCESS (0.551s)
[309.247678] Starting dynamic subtest: vecs0
[309.764593] Dynamic subtest vecs0: SUCCESS (0.525s)
[309.773841] Starting dynamic subtest: vecs1
[310.588393] Dynamic subtest vecs1: SUCCESS (0.823s)
[310.597538] Starting dynamic subtest: ccs0
[311.134851] Dynamic subtest ccs0: SUCCESS (0.545s)
[311.135984] Subtest preempt-other: SUCCESS (4.062s)
[311.559299] [063/131] (710s left) tools_test (sysfs_l3_parity)
[311.618140] Starting subtest: sysfs_l3_parity
[311.685393] Subtest sysfs_l3_parity: SKIP (0.072s)
[311.769035] [064/131] (710s left) gem_tiled_partial_pwrite_pread (writes)
[311.852433] Subtest writes: SKIP (0.000s)
[311.944893] [065/131] (710s left) gem_userptr_blits (process-exit-busy)
[312.043949] Starting subtest: process-exit-busy
[312.059258] Subtest process-exit-busy: SUCCESS (0.015s)
[312.241812] [066/131] (710s left) gem_create (create-clear)
[312.322418] Starting subtest: create-clear
[312.323341] Starting dynamic subtest: lmem0
[347.683652] Dynamic subtest lmem0: SUCCESS (35.356s)
[347.702683] Starting dynamic subtest: smem0
[381.389759] Dynamic subtest smem0: SUCCESS (33.703s)
[381.390579] Subtest create-clear: SUCCESS (69.062s)
[381.866377] [067/131] (640s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[382.071253] Starting subtest: y-tiled-16bpp-rotate-270
[382.073030] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[382.234070] [068/131] (640s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[382.464975] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[385.170521] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (2.705s)
[385.377919] [069/131] (637s left) gem_exec_params (dr4-dirt)
[385.463930] Starting subtest: DR4-dirt
[385.464826] Subtest DR4-dirt: SUCCESS (0.000s)
[385.597409] [070/131] (637s left) gem_exec_fence (keep-in-fence)
[385.807813] Starting subtest: keep-in-fence
[385.808751] Starting dynamic subtest: rcs0
[385.904423] Dynamic subtest rcs0: SUCCESS (0.096s)
[385.923222] Starting dynamic subtest: bcs0
[385.961750] Dynamic subtest bcs0: SUCCESS (0.055s)
[385.978480] Starting dynamic subtest: vcs0
[386.020516] Dynamic subtest vcs0: SUCCESS (0.055s)
[386.031032] Starting dynamic subtest: vcs1
[386.074721] Dynamic subtest vcs1: SUCCESS (0.053s)
[386.098822] Starting dynamic subtest: vecs0
[386.136832] Dynamic subtest vecs0: SUCCESS (0.060s)
[386.173889] Starting dynamic subtest: vecs1
[386.212901] Dynamic subtest vecs1: SUCCESS (0.072s)
[386.232601] Starting dynamic subtest: ccs0
[386.435390] Dynamic subtest ccs0: SUCCESS (0.221s)
[386.436385] Subtest keep-in-fence: SUCCESS (0.628s)
[387.199069] [071/131] (635s left) gem_eio (in-flight-10ms)
[387.479395] Starting subtest: in-flight-10ms
[392.397996] Subtest in-flight-10ms: SUCCESS (4.919s)
[392.637421] [072/131] (630s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[392.832608] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[392.835048] Starting dynamic subtest: pipe-A-valid-mode
[392.937733] Dynamic subtest pipe-A-valid-mode: SKIP (0.102s)
[392.940223] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.105s)
[393.146613] [073/131] (630s left) kms_content_protection (content-type-change)
[393.416588] Starting subtest: content-type-change
[393.981532] Subtest content-type-change: SKIP (0.562s)
[394.341411] [074/131] (628s left) kms_fbcon_fbt (psr-suspend)
[394.425407] Starting subtest: psr-suspend
[394.427161] Subtest psr-suspend: SKIP (0.000s)
[394.599914] [075/131] (628s left) gem_exec_reloc (basic-wc-active)
[394.684122] Subtest basic-wc-active: SKIP (0.000s)
[394.775512] [076/131] (628s left) syncobj_wait (invalid-single-wait-unsubmitted)
[394.858490] Starting subtest: invalid-single-wait-unsubmitted
[394.859404] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[395.008306] [077/131] (628s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[395.208124] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[395.209893] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[395.351149] [078/131] (628s left) gem_ctx_persistence (legacy-engines-mixed)
[395.438610] Starting subtest: legacy-engines-mixed
[395.439521] Starting dynamic subtest: render
[395.577539] Dynamic subtest render: SUCCESS (0.138s)
[395.593538] Starting dynamic subtest: bsd1
[395.636824] Dynamic subtest bsd1: SUCCESS (0.057s)
[395.673175] Starting dynamic subtest: bsd2
[395.708406] Dynamic subtest bsd2: SUCCESS (0.068s)
[395.727905] Starting dynamic subtest: blt
[395.768842] Dynamic subtest blt: SUCCESS (0.058s)
[395.802612] Starting dynamic subtest: vebox
[395.832275] Dynamic subtest vebox: SUCCESS (0.060s)
[395.833305] Subtest legacy-engines-mixed: SUCCESS (0.394s)
[396.027806] [079/131] (627s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[396.304904] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[396.479632] [080/131] (627s left) gem_userptr_blits (readonly-pwrite-unsync)
[396.568997] Subtest readonly-pwrite-unsync: SKIP (0.000s)
[396.763130] [081/131] (627s left) kms_flip (plain-flip-fb-recreate)
[396.959016] Starting subtest: plain-flip-fb-recreate
[396.963572] Starting dynamic subtest: A-DP3
[405.103116] Dynamic subtest A-DP3: SUCCESS (8.138s)
[405.144309] Starting dynamic subtest: B-DP3
[413.183318] Dynamic subtest B-DP3: SUCCESS (8.074s)
[413.221312] Starting dynamic subtest: C-DP3
[421.275990] Dynamic subtest C-DP3: SUCCESS (8.087s)
[421.309911] Starting dynamic subtest: D-DP3
[429.337098] Dynamic subtest D-DP3: SUCCESS (8.055s)
[429.345426] Subtest plain-flip-fb-recreate: SUCCESS (32.385s)
[429.701880] [082/131] (594s left) gem_pipe_control_store_loop (fresh-buffer)
[429.790347] Starting subtest: fresh-buffer
[431.971162] Subtest fresh-buffer: SUCCESS (2.180s)
[432.155731] [083/131] (591s left) gem_exec_alignment (pi)
[432.243489] Starting subtest: pi
[449.312533] Subtest pi: SUCCESS (17.068s)
[449.778961] [084/131] (574s left) kms_plane (pixel-format)
[450.037511] Starting subtest: pixel-format
[450.073308] Starting dynamic subtest: pipe-A-plane-0
[458.157669] Dynamic subtest pipe-A-plane-0: SUCCESS (8.083s)
[458.172417] Starting dynamic subtest: pipe-A-plane-3
[462.556539] Dynamic subtest pipe-A-plane-3: SUCCESS (4.395s)
[462.568921] Starting dynamic subtest: pipe-A-plane-5
[462.790297] Dynamic subtest pipe-A-plane-5: SUCCESS (0.232s)
[463.048549] Starting dynamic subtest: pipe-B-plane-0
[470.880696] Dynamic subtest pipe-B-plane-0: SUCCESS (7.849s)
[470.892591] Starting dynamic subtest: pipe-B-plane-3
[475.348973] Dynamic subtest pipe-B-plane-3: SUCCESS (4.466s)
[475.393436] Starting dynamic subtest: pipe-B-plane-5
[475.598234] Dynamic subtest pipe-B-plane-5: SUCCESS (0.245s)
[475.672815] Subtest pixel-format: SUCCESS (25.634s)
[475.957851] [085/131] (548s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[476.049601] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[476.050486] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[476.175842] [086/131] (548s left) kms_flip (flip-vs-dpms-on-nop)
[476.374982] Starting subtest: flip-vs-dpms-on-nop
[476.379557] Starting dynamic subtest: A-DP3
[477.510649] Dynamic subtest A-DP3: SUCCESS (1.131s)
[477.523824] Starting dynamic subtest: B-DP3
[478.565900] Dynamic subtest B-DP3: SUCCESS (1.053s)
[478.578383] Starting dynamic subtest: C-DP3
[479.642284] Dynamic subtest C-DP3: SUCCESS (1.075s)
[479.655299] Starting dynamic subtest: D-DP3
[480.710379] Dynamic subtest D-DP3: SUCCESS (1.067s)
[480.712712] Subtest flip-vs-dpms-on-nop: SUCCESS (4.337s)
[481.047579] [087/131] (543s left) kms_vblank (ts-continuation-modeset-rpm)
[481.248467] Starting subtest: ts-continuation-modeset-rpm
[481.250952] Starting dynamic subtest: pipe-A-DP-3
[483.150437] Dynamic subtest pipe-A-DP-3: SUCCESS (1.899s)
[483.169304] Starting dynamic subtest: pipe-D-DP-3
[484.023278] Dynamic subtest pipe-D-DP-3: SUCCESS (0.868s)
[484.024258] Subtest ts-continuation-modeset-rpm: SUCCESS (2.775s)
[484.281114] [088/131] (540s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[484.365493] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[484.467110] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.101s)
[484.605932] [089/131] (539s left) kms_pm_rpm (universal-planes-dpms)
[487.025749] Starting subtest: universal-planes-dpms
[487.031695] Starting dynamic subtest: plane-33
[489.861120] Dynamic subtest plane-33: SUCCESS (2.831s)
[489.904710] Starting dynamic subtest: plane-43
[492.701730] Dynamic subtest plane-43: SUCCESS (2.837s)
[492.714135] Starting dynamic subtest: plane-53
[495.544929] Dynamic subtest plane-53: SUCCESS (2.840s)
[495.590579] Starting dynamic subtest: plane-63
[498.384695] Dynamic subtest plane-63: SUCCESS (2.835s)
[498.429501] Starting dynamic subtest: plane-73
[501.354738] Dynamic subtest plane-73: SUCCESS (2.965s)
[501.399276] Starting dynamic subtest: plane-83
[504.192523] Dynamic subtest plane-83: SUCCESS (2.832s)
[504.194339] Subtest universal-planes-dpms: SUCCESS (17.168s)
[504.582093] [090/131] (519s left) kms_atomic_transition (modeset-transition-nonblocking)
[504.783442] Starting subtest: modeset-transition-nonblocking
[504.784300] Starting dynamic subtest: 1x-outputs
[507.358558] Dynamic subtest 1x-outputs: SUCCESS (2.575s)
[507.413569] Subtest modeset-transition-nonblocking: SUCCESS (2.630s)
[507.689973] [091/131] (516s left) kms_cursor_crc (cursor-offscreen-max-size)
[508.210767] Starting subtest: cursor-offscreen-max-size
[508.213374] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[508.408712] [092/131] (516s left) gem_exec_balancer (smoke)
[508.505391] Starting subtest: smoke
[532.182187] Subtest smoke: SUCCESS (23.677s)
[533.203464] [093/131] (491s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[533.295892] Starting subtest: map-fixed-invalidate-overlap
[533.297660] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[533.477424] [094/131] (491s left) i915_pm_rpm (sysfs-read)
[535.091048] Starting subtest: sysfs-read
[535.397381] Subtest sysfs-read: SUCCESS (0.309s)
[535.801214] [095/131] (489s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[535.883387] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[535.987315] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.103s)
[536.132362] [096/131] (488s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[536.214294] Starting subtest: multi-wait-for-submit-available-signaled
[536.215303] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.000s)
[536.398021] [097/131] (488s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[536.595991] Starting subtest: addfb25-y-tiled-small-legacy
[536.597517] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[536.751745] [098/131] (488s left) gem_exec_whisper (basic-forked)
[536.842594] Starting subtest: basic-forked
[544.100304] Subtest basic-forked: SUCCESS (7.256s)
[544.365916] [099/131] (480s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[544.569517] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[544.571889] Starting dynamic subtest: pipe-A-DP-3
[544.580225] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[544.590969] Starting dynamic subtest: pipe-B-DP-3
[544.599382] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[544.609947] Starting dynamic subtest: pipe-C-DP-3
[544.618197] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[544.628889] Starting dynamic subtest: pipe-D-DP-3
[544.640145] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[544.642529] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SKIP (0.007s)
[545.034238] [100/131] (480s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[545.229487] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[545.231886] Starting dynamic subtest: pipe-A-DP-3
[549.986836] Dynamic subtest pipe-A-DP-3: SUCCESS (4.752s)
[550.001438] Starting dynamic subtest: pipe-B-DP-3
[550.737619] Dynamic subtest pipe-B-DP-3: SUCCESS (0.745s)
[550.774494] Starting dynamic subtest: pipe-C-DP-3
[551.501696] Dynamic subtest pipe-C-DP-3: SUCCESS (0.756s)
[551.539706] Starting dynamic subtest: pipe-D-DP-3
[552.290919] Dynamic subtest pipe-D-DP-3: SUCCESS (0.774s)
[552.292721] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SUCCESS (7.051s)
[552.687381] [101/131] (472s left) device_reset (unbind-reset-rebind)
[552.775843] Starting subtest: unbind-reset-rebind
[555.343561] Subtest unbind-reset-rebind: SUCCESS (2.567s)
[555.401905] [102/131] (470s left) gem_sync (basic-many-each)
[555.500058] Starting subtest: basic-many-each
[558.010149] Subtest basic-many-each: SUCCESS (2.509s)
[558.271536] [103/131] (467s left) kms_frontbuffer_tracking (fbc-1p-rte)
[558.479129] Starting subtest: fbc-1p-rte
[561.972282] Subtest fbc-1p-rte: SUCCESS (3.494s)
[562.174019] [104/131] (463s left) i915_pm_rpm (debugfs-forcewake-user)
[564.094985] Starting subtest: debugfs-forcewake-user
[574.711636] Subtest debugfs-forcewake-user: SUCCESS (10.617s)
[575.073308] [105/131] (450s left) perf (sysctl-defaults)
[575.173605] Starting subtest: sysctl-defaults
[575.174446] Subtest sysctl-defaults: SUCCESS (0.000s)
[575.487563] [106/131] (450s left) gem_create (hog-create)
[575.576324] Starting subtest: hog-create
[575.577284] Starting dynamic subtest: lmem0
[607.862270] Dynamic subtest lmem0: SUCCESS (32.285s)
[607.875372] Starting dynamic subtest: smem0
[640.148316] Dynamic subtest smem0: SUCCESS (32.284s)
[640.149305] Subtest hog-create: SUCCESS (64.572s)
[640.407406] [107/131] (385s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[640.613207] Starting subtest: yf-tiled-64bpp-rotate-0
[640.615020] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[640.748095] [108/131] (385s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-blt)
[640.948013] Starting subtest: fbc-1p-offscren-pri-indfb-draw-blt
[643.247350] Subtest fbc-1p-offscren-pri-indfb-draw-blt: SUCCESS (2.299s)
[643.459841] [109/131] (382s left) gem_pwrite_snooped
[643.627109] [110/131] (382s left) gem_mmap_gtt (fault-concurrent)
[643.707195] Subtest fault-concurrent: SKIP (0.000s)
[643.788901] [111/131] (382s left) gem_softpin (noreloc-s3)
[643.874451] Starting subtest: noreloc-S3
[664.676805] Subtest noreloc-S3: SUCCESS (5.487s)
[664.806189] [112/131] (361s left) api_intel_bb (lot-of-buffers)
[664.894058] Starting subtest: lot-of-buffers
[668.198468] Subtest lot-of-buffers: SUCCESS (3.305s)
[668.373661] [113/131] (357s left) gen7_exec_parse (load-register-reg)
[668.455356] Subtest load-register-reg: SKIP (0.000s)
[668.532365] [114/131] (357s left) kms_plane_scaling (planes-scaler-unity-scaling)
[668.730905] Starting subtest: planes-scaler-unity-scaling
[668.731767] Starting dynamic subtest: pipe-A
[668.817973] Dynamic subtest pipe-A: SUCCESS (0.086s)
[668.837239] Starting dynamic subtest: pipe-B
[669.015416] Dynamic subtest pipe-B: SUCCESS (0.196s)
[669.034437] Starting dynamic subtest: pipe-C
[669.217791] Dynamic subtest pipe-C: SUCCESS (0.201s)
[669.241581] Starting dynamic subtest: pipe-D
[669.431675] Dynamic subtest pipe-D: SUCCESS (0.212s)
[669.432711] Subtest planes-scaler-unity-scaling: SUCCESS (0.701s)
[669.747994] [115/131] (356s left) gem_lmem_swapping (verify-random-ccs)
[672.404406] Starting subtest: verify-random-ccs
[672.405424] Starting dynamic subtest: lmem0
[679.632889] Dynamic subtest lmem0: SUCCESS (7.227s)
[679.633842] Subtest verify-random-ccs: SUCCESS (7.229s)
[680.699547] [FACT gem_lmem_swapping (verify-random-ccs)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[680.700558] [FACT gem_lmem_swapping (verify-random-ccs)] deleted: kernel.kmod_is_loaded.i915: true
[680.702833] [116/131] (345s left) kms_big_fb (4-tiled-addfb-size-overflow)
[682.286602] Starting subtest: 4-tiled-addfb-size-overflow
[682.287411] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.001s)
[682.416357] [FACT kms_big_fb (4-tiled-addfb-size-overflow)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[682.418694] [FACT kms_big_fb (4-tiled-addfb-size-overflow)] new: kernel.kmod_is_loaded.i915: true
[682.421766] [117/131] (343s left) kms_properties (get_properties-sanity-atomic)
[682.618916] Starting subtest: get_properties-sanity-atomic
[682.622551] Subtest get_properties-sanity-atomic: SUCCESS (0.004s)
[682.732603] [118/131] (343s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[682.933998] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[682.936549] Starting dynamic subtest: pipe-A-valid-mode
[684.688555] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.752s)
[684.689440] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (1.754s)
[684.936977] [119/131] (341s left) kms_psr (psr2-cursor-mmap-gtt)
[685.132555] Subtest psr2-cursor-mmap-gtt: SKIP (0.000s)
[685.193432] [120/131] (341s left) kms_psr (fbc-pr-sprite-blt)
[685.387521] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[685.443422] [121/131] (341s left) syncobj_wait (single-wait-submitted)
[685.528184] Starting subtest: single-wait-submitted
[685.630978] Subtest single-wait-submitted: SUCCESS (0.102s)
[685.777696] [122/131] (340s left) gem_close (basic)
[685.865771] Starting subtest: basic
[685.866718] Subtest basic: SUCCESS (0.000s)
[686.007787] [123/131] (340s left) prime_mmap (test_forked_cpu_write)
[686.086731] Starting subtest: test_forked_cpu_write
[686.087620] Starting dynamic subtest: test_forked_cpu_write-smem
[686.094185] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.008s)
[686.107664] Starting dynamic subtest: test_forked_cpu_write-lmem0
[686.109001] Dynamic subtest test_forked_cpu_write-lmem0: SUCCESS (0.008s)
[686.110215] Subtest test_forked_cpu_write: SUCCESS (0.019s)
[686.261570] [124/131] (340s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[686.459414] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[686.461072] Subtest psr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[686.579368] [125/131] (340s left) perf_pmu (busy-no-semaphores)
[686.652433] Starting subtest: busy-no-semaphores
[686.653344] Starting dynamic subtest: rcs0
[687.238764] Dynamic subtest rcs0: SUCCESS (0.585s)
[687.256521] Starting dynamic subtest: bcs0
[687.795741] Dynamic subtest bcs0: SUCCESS (0.552s)
[687.811086] Starting dynamic subtest: vcs0
[688.349610] Dynamic subtest vcs0: SUCCESS (0.549s)
[688.369995] Starting dynamic subtest: vcs1
[688.902729] Dynamic subtest vcs1: SUCCESS (0.548s)
[688.918017] Starting dynamic subtest: vecs0
[689.456506] Dynamic subtest vecs0: SUCCESS (0.549s)
[689.476810] Starting dynamic subtest: vecs1
[690.009931] Dynamic subtest vecs1: SUCCESS (0.549s)
[690.025617] Starting dynamic subtest: ccs0
[690.563941] Dynamic subtest ccs0: SUCCESS (0.549s)
[690.566008] Subtest busy-no-semaphores: SUCCESS (3.913s)
[690.791563] [126/131] (336s left) kms_cursor_edge_walk (128x128-left-edge)
[690.988991] Starting subtest: 128x128-left-edge
[690.991524] Starting dynamic subtest: pipe-A-DP-3
[694.467383] Dynamic subtest pipe-A-DP-3: SUCCESS (3.477s)
[694.485830] Starting dynamic subtest: pipe-D-DP-3
[697.794833] Dynamic subtest pipe-D-DP-3: SUCCESS (3.320s)
[697.795865] Subtest 128x128-left-edge: SUCCESS (6.801s)
[698.044837] [127/131] (329s left) kms_pipe_stress (stress-xrgb8888-yftiled)
[698.250746] Starting subtest: stress-xrgb8888-yftiled
[698.253846] Subtest stress-xrgb8888-yftiled: SKIP (0.000s)
[698.318067] [128/131] (328s left) gem_exec_schedule (wide)
[698.525305] Starting subtest: wide
[698.526200] Starting dynamic subtest: rcs0
[710.471509] Dynamic subtest rcs0: SUCCESS (11.936s)
[710.486116] Starting dynamic subtest: bcs0
[723.469368] Dynamic subtest bcs0: SUCCESS (12.994s)
[723.482612] Starting dynamic subtest: vcs0
[736.722354] Dynamic subtest vcs0: SUCCESS (13.244s)
[736.741354] Starting dynamic subtest: vcs1
[749.759054] Dynamic subtest vcs1: SUCCESS (13.041s)
[749.772571] Starting dynamic subtest: vecs0
[762.844523] Dynamic subtest vecs0: SUCCESS (13.084s)
[762.858510] Starting dynamic subtest: vecs1
[775.972642] Dynamic subtest vecs1: SUCCESS (13.127s)
[775.990323] Starting dynamic subtest: ccs0
[789.281839] Dynamic subtest ccs0: SUCCESS (13.305s)
[789.282785] Subtest wide: SUCCESS (90.742s)
[791.234143] [129/131] (236s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[791.325314] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[791.327881] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[791.557849] [130/131] (235s left) syncobj_timeline (invalid-query-one-illegal-handle)
[791.639703] Starting subtest: invalid-query-one-illegal-handle
[791.640787] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s)
[791.784337] [131/131] (235s left) gem_mmap_offset (pf-nonblock)
[791.861763] Starting subtest: pf-nonblock
[791.899887] Subtest pf-nonblock: SUCCESS (0.038s)
[792.083536] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_flip
results: parsing output: 2/ for test: kms_plane
results: parsing output: 3/ for test: kms_flip
results: parsing output: 4/ for test: gem_tiled_pread_basic
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: kms_psr
results: parsing output: 7/ for test: kms_ccs
results: parsing output: 8/ for test: kms_getfb
results: parsing output: 9/ for test: kms_pm_rpm
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_chamelium_hpd
results: parsing output: 12/ for test: gem_pread
results: parsing output: 13/ for test: gem_bad_reloc
results: parsing output: 14/ for test: sriov_basic
results: parsing output: 15/ for test: gem_ctx_param
results: parsing output: 16/ for test: syncobj_wait
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_flip
results: parsing output: 19/ for test: kms_psr
results: parsing output: 20/ for test: gem_softpin
results: parsing output: 21/ for test: drm_read
results: parsing output: 22/ for test: i915_drm_fdinfo
results: parsing output: 23/ for test: i915_drm_fdinfo
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: kms_ccs
results: parsing output: 27/ for test: kms_dp_link_training
results: parsing output: 28/ for test: kms_psr2_sf
results: parsing output: 29/ for test: perf
results: parsing output: 30/ for test: kms_cursor_legacy
results: parsing output: 31/ for test: kms_color
results: parsing output: 32/ for test: kms_pipe_b_c_ivb
results: parsing output: 33/ for test: kms_async_flips
results: parsing output: 34/ for test: kms_lease
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: sysfs_timeslice_duration
results: parsing output: 37/ for test: gem_userptr_blits
results: parsing output: 38/ for test: gem_mmap_gtt
results: parsing output: 39/ for test: syncobj_wait
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: gem_exec_fence
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: syncobj_timeline
results: parsing output: 44/ for test: gem_spin_batch
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: api_intel_allocator
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_big_fb
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_cursor_crc
results: parsing output: 52/ for test: gem_request_retire
results: parsing output: 53/ for test: gem_exec_schedule
results: parsing output: 54/ for test: gem_userptr_blits
results: parsing output: 55/ for test: kms_ccs
results: parsing output: 56/ for test: kms_psr2_sf
results: parsing output: 57/ for test: kms_selftest
results: parsing output: 58/ for test: kms_vblank
results: parsing output: 59/ for test: kms_hdr
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: gem_exec_schedule
results: parsing output: 62/ for test: tools_test
results: parsing output: 63/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 64/ for test: gem_userptr_blits
results: parsing output: 65/ for test: gem_create
results: parsing output: 66/ for test: kms_big_fb
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: gem_exec_params
results: parsing output: 69/ for test: gem_exec_fence
results: parsing output: 70/ for test: gem_eio
results: parsing output: 71/ for test: kms_flip_scaled_crc
results: parsing output: 72/ for test: kms_content_protection
results: parsing output: 73/ for test: kms_fbcon_fbt
results: parsing output: 74/ for test: gem_exec_reloc
results: parsing output: 75/ for test: syncobj_wait
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: gem_ctx_persistence
results: parsing output: 78/ for test: kms_chamelium_edid
results: parsing output: 79/ for test: gem_userptr_blits
results: parsing output: 80/ for test: kms_flip
results: parsing output: 81/ for test: gem_pipe_control_store_loop
results: parsing output: 82/ for test: gem_exec_alignment
results: parsing output: 83/ for test: kms_plane
results: parsing output: 84/ for test: syncobj_wait
results: parsing output: 85/ for test: kms_flip
results: parsing output: 86/ for test: kms_vblank
results: parsing output: 87/ for test: syncobj_timeline
results: parsing output: 88/ for test: kms_pm_rpm
results: parsing output: 89/ for test: kms_atomic_transition
results: parsing output: 90/ for test: kms_cursor_crc
results: parsing output: 91/ for test: gem_exec_balancer
results: parsing output: 92/ for test: gem_userptr_blits
results: parsing output: 93/ for test: i915_pm_rpm
results: parsing output: 94/ for test: syncobj_timeline
results: parsing output: 95/ for test: syncobj_timeline
results: parsing output: 96/ for test: kms_addfb_basic
results: parsing output: 97/ for test: gem_exec_whisper
results: parsing output: 98/ for test: kms_ccs
results: parsing output: 99/ for test: kms_ccs
results: parsing output: 100/ for test: device_reset
results: parsing output: 101/ for test: gem_sync
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: i915_pm_rpm
results: parsing output: 104/ for test: perf
results: parsing output: 105/ for test: gem_create
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: gem_pwrite_snooped
results: parsing output: 109/ for test: gem_mmap_gtt
results: parsing output: 110/ for test: gem_softpin
results: parsing output: 111/ for test: api_intel_bb
results: parsing output: 112/ for test: gen7_exec_parse
results: parsing output: 113/ for test: kms_plane_scaling
results: parsing output: 114/ for test: gem_lmem_swapping
results: parsing output: 115/ for test: kms_big_fb
results: parsing output: 116/ for test: kms_properties
results: parsing output: 117/ for test: kms_flip_scaled_crc
results: parsing output: 118/ for test: kms_psr
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: syncobj_wait
results: parsing output: 121/ for test: gem_close
results: parsing output: 122/ for test: prime_mmap
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: perf_pmu
results: parsing output: 125/ for test: kms_cursor_edge_walk
results: parsing output: 126/ for test: kms_pipe_stress
results: parsing output: 127/ for test: gem_exec_schedule
results: parsing output: 128/ for test: gem_render_copy
results: parsing output: 129/ for test: syncobj_timeline
results: parsing output: 130/ for test: gem_mmap_offset
Done.