[64.773766] Initializing watchdogs
[64.773830]   /dev/watchdog0
[64.793477] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[64.804117] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[64.807718] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[64.809946] [001/130] (960s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[64.989434] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[64.990365] Starting dynamic subtest: pipe-A-DP-3
[64.998443] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[65.005982] Starting dynamic subtest: pipe-B-DP-3
[65.014161] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[65.022396] Starting dynamic subtest: pipe-C-DP-3
[65.037982] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[65.045355] Starting dynamic subtest: pipe-D-DP-3
[65.055669] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[65.057571] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SKIP (0.004s)
[65.473102] [002/130] (959s left) gem_fence_thrash (bo-write-verify-x)
[65.516058] Starting subtest: bo-write-verify-x
[65.541903] Subtest bo-write-verify-x: SKIP (0.026s)
[65.629937] [003/130] (959s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[65.809568] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[65.811247] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[65.991305] [004/130] (959s left) gem_exec_parallel (contexts)
[66.076418] Starting subtest: contexts
[66.077355] Starting dynamic subtest: rcs0
[70.741208] Dynamic subtest rcs0: SUCCESS (4.667s)
[70.749437] Starting dynamic subtest: bcs0
[74.646694] Dynamic subtest bcs0: SUCCESS (3.906s)
[74.654810] Starting dynamic subtest: vcs0
[79.146679] Dynamic subtest vcs0: SUCCESS (4.500s)
[79.154803] Starting dynamic subtest: vcs1
[83.068695] Dynamic subtest vcs1: SUCCESS (3.922s)
[83.077157] Starting dynamic subtest: vecs0
[87.054802] Dynamic subtest vecs0: SUCCESS (3.986s)
[87.063556] Starting dynamic subtest: vecs1
[91.376738] Dynamic subtest vecs1: SUCCESS (4.322s)
[91.385172] Starting dynamic subtest: ccs0
[95.709258] Dynamic subtest ccs0: SUCCESS (4.332s)
[95.710384] Subtest contexts: SUCCESS (29.637s)
[96.034773] [005/130] (929s left) gem_wait (invalid-buf)
[96.106117] Starting subtest: invalid-buf
[96.107079] Subtest invalid-buf: SUCCESS (0.000s)
[96.400017] [006/130] (929s left) gem_tiled_wb
[96.540078] [007/130] (929s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[96.733991] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[96.735598] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[96.935394] [008/130] (928s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[97.123538] Starting subtest: x-tiled-8bpp-rotate-90
[97.180507] Subtest x-tiled-8bpp-rotate-90: SKIP (0.055s)
[97.405912] [009/130] (928s left) i915_drm_fdinfo (most-busy-idle-check-all)
[97.466842] Starting subtest: most-busy-idle-check-all
[97.467706] Starting dynamic subtest: rcs0
[97.492462] Dynamic subtest rcs0: SKIP (0.025s)
[97.501142] Starting dynamic subtest: bcs0
[97.502943] Dynamic subtest bcs0: SKIP (0.000s)
[97.523701] Starting dynamic subtest: vcs0
[97.526107] Dynamic subtest vcs0: SKIP (0.000s)
[97.541096] Starting dynamic subtest: vcs1
[97.542970] Dynamic subtest vcs1: SKIP (0.000s)
[97.553189] Starting dynamic subtest: vecs0
[97.555372] Dynamic subtest vecs0: SKIP (0.000s)
[97.563557] Starting dynamic subtest: vecs1
[97.565578] Dynamic subtest vecs1: SKIP (0.000s)
[97.573760] Starting dynamic subtest: ccs0
[97.576066] Dynamic subtest ccs0: SKIP (0.000s)
[97.579521] Subtest most-busy-idle-check-all: SKIP (0.029s)
[97.619913] [010/130] (928s left) gem_exec_reloc (basic-wc-noreloc)
[97.732534] Subtest basic-wc-noreloc: SKIP (0.000s)
[97.818587] [011/130] (928s left) gem_mmap_offset (blt-coherency)
[97.888029] Starting subtest: blt-coherency
[97.923791] Subtest blt-coherency: SUCCESS (0.035s)
[98.137637] [012/130] (927s left) kms_dp_aux_dev
[98.804625] [013/130] (927s left) gem_exec_params (cliprects-invalid)
[98.879867] Starting subtest: cliprects-invalid
[98.880728] Subtest cliprects-invalid: SUCCESS (0.000s)
[99.107621] [014/130] (927s left) vgem_basic (mmap)
[99.228066] Starting subtest: mmap
[99.234120] Subtest mmap: SUCCESS (0.007s)
[99.373589] [FACT vgem_basic (mmap)] new: kernel.kmod_is_loaded.vgem: true
[99.375227] [015/130] (926s left) kms_getfb (getfb-handle-closed)
[99.560968] Starting subtest: getfb-handle-closed
[99.561843] Subtest getfb-handle-closed: SUCCESS (0.000s)
[99.774644] [016/130] (926s left) kms_cursor_crc (cursor-offscreen-max-size)
[100.281381] Starting subtest: cursor-offscreen-max-size
[100.284676] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[100.509232] [017/130] (925s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[100.693914] Starting subtest: cursorB-vs-flipB-varying-size
[100.695662] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[100.871631] [018/130] (925s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[101.067204] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[101.068924] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[101.258517] [019/130] (925s left) kms_big_fb (linear-8bpp-rotate-270)
[101.457341] Starting subtest: linear-8bpp-rotate-270
[101.512130] Subtest linear-8bpp-rotate-270: SKIP (0.054s)
[101.739271] [020/130] (924s left) kms_dp_linktrain_fallback (dp-fallback)
[101.922865] Starting subtest: dp-fallback
[111.741501] Subtest dp-fallback: SUCCESS (9.817s)
[112.151161] [021/130] (914s left) core_debugfs (read-all-entries)
[112.229251] Starting subtest: read-all-entries
[112.311434] Subtest read-all-entries: SUCCESS (0.082s)
[112.507412] [022/130] (914s left) gem_ctx_param (invalid-get-engines)
[112.580575] Starting subtest: invalid-get-engines
[112.582418] Subtest invalid-get-engines: SUCCESS (0.002s)
[112.777725] [023/130] (914s left) vgem_basic (setversion)
[112.844364] Starting subtest: setversion
[112.846516] Subtest setversion: SUCCESS (0.000s)
[112.970786] [024/130] (913s left) kms_psr (psr-primary-render)
[113.155730] Subtest psr-primary-render: SKIP (0.000s)
[113.217654] [025/130] (913s left) kms_getfb (getfb-handle-zero)
[113.399435] Starting subtest: getfb-handle-zero
[113.400303] Subtest getfb-handle-zero: SUCCESS (0.000s)
[113.607867] [026/130] (913s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[113.790356] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[113.791262] Starting dynamic subtest: pipe-A-valid-mode
[113.893315] Dynamic subtest pipe-A-valid-mode: SKIP (0.100s)
[113.895637] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.102s)
[114.147827] [027/130] (912s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[114.229252] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[114.292789] [028/130] (912s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[114.483391] Starting subtest: fbc-farfromfence-mmap-gtt
[114.485016] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[114.682618] [029/130] (912s left) kms_plane_multiple (2x-tiling-4)
[114.866704] Starting subtest: 2x-tiling-4
[114.868394] Subtest 2x-tiling-4: SKIP (0.000s)
[115.020053] [030/130] (912s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[115.203905] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[115.204785] Starting dynamic subtest: pipe-A-DP-3
[115.213039] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[115.221560] Starting dynamic subtest: pipe-B-DP-3
[115.229912] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[115.238336] Starting dynamic subtest: pipe-C-DP-3
[115.246428] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[115.254779] Starting dynamic subtest: pipe-D-DP-3
[115.263959] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[115.265820] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SKIP (0.004s)
[115.657974] [031/130] (911s left) gem_eio (in-flight-suspend)
[115.952154] Starting subtest: in-flight-suspend
[157.850355] Subtest in-flight-suspend: SUCCESS (11.912s)
[158.137293] [032/130] (869s left) gen7_exec_parse (bitmasks)
[158.220350] Subtest bitmasks: SKIP (0.000s)
[158.303256] [033/130] (869s left) gem_mmap_gtt (medium-copy-xy)
[158.383087] Subtest medium-copy-XY: SKIP (0.000s)
[158.449811] [034/130] (869s left) kms_chamelium_frames (hdmi-crc-single)
[158.716744] Subtest hdmi-crc-single: SKIP (0.000s)
[158.870089] [035/130] (868s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[159.059457] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[159.061179] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[159.262651] [036/130] (868s left) gem_exec_schedule (timeslicing)
[159.352703] Starting subtest: timeslicing
[159.353582] Starting dynamic subtest: rcs0
[159.377600] Dynamic subtest rcs0: SUCCESS (0.025s)
[159.389071] Starting dynamic subtest: bcs0
[159.398787] Dynamic subtest bcs0: SUCCESS (0.021s)
[159.411075] Starting dynamic subtest: vcs0
[159.420812] Dynamic subtest vcs0: SUCCESS (0.022s)
[159.432925] Starting dynamic subtest: vcs1
[159.442492] Dynamic subtest vcs1: SUCCESS (0.021s)
[159.454736] Starting dynamic subtest: vecs0
[159.466463] Dynamic subtest vecs0: SUCCESS (0.023s)
[159.478642] Starting dynamic subtest: vecs1
[159.488355] Dynamic subtest vecs1: SUCCESS (0.021s)
[159.500570] Starting dynamic subtest: ccs0
[159.509669] Dynamic subtest ccs0: SUCCESS (0.021s)
[159.510649] Subtest timeslicing: SUCCESS (0.157s)
[159.977460] [037/130] (867s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[160.165336] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[160.222021] [038/130] (867s left) gem_exec_schedule (deep)
[160.454702] Starting subtest: deep
[160.456474] Starting dynamic subtest: rcs0
[175.750541] Dynamic subtest rcs0: SUCCESS (15.296s)
[175.761930] Starting dynamic subtest: bcs0
[191.013631] Dynamic subtest bcs0: SUCCESS (15.262s)
[191.025063] Starting dynamic subtest: vcs0
[206.760591] Dynamic subtest vcs0: SUCCESS (15.745s)
[206.772059] Starting dynamic subtest: vcs1
[222.097159] Dynamic subtest vcs1: SUCCESS (15.336s)
[222.108531] Starting dynamic subtest: vecs0
[237.604735] Dynamic subtest vecs0: SUCCESS (15.507s)
[237.616230] Starting dynamic subtest: vecs1
[253.432562] Dynamic subtest vecs1: SUCCESS (15.827s)
[253.444058] Starting dynamic subtest: ccs0
[269.071618] Dynamic subtest ccs0: SUCCESS (15.633s)
[269.072518] Subtest deep: SUCCESS (108.611s)
[269.993689] [039/130] (757s left) kms_color (degamma)
[270.179306] Starting subtest: degamma
[270.180210] Starting dynamic subtest: pipe-A-DP-3
[270.832764] Dynamic subtest pipe-A-DP-3: SUCCESS (0.652s)
[270.852937] Starting dynamic subtest: pipe-B-DP-3
[271.408771] Dynamic subtest pipe-B-DP-3: SUCCESS (0.576s)
[271.423076] Starting dynamic subtest: pipe-C-DP-3
[272.012023] Dynamic subtest pipe-C-DP-3: SUCCESS (0.603s)
[272.025157] Starting dynamic subtest: pipe-D-DP-3
[272.619993] Dynamic subtest pipe-D-DP-3: SUCCESS (0.606s)
[272.621009] Subtest degamma: SUCCESS (2.439s)
[272.953359] [040/130] (755s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[273.146040] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[273.147739] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[273.358036] [041/130] (754s left) gem_eio (banned)
[273.688487] Starting subtest: banned
[274.747141] Subtest banned: SUCCESS (1.059s)
[275.075506] [042/130] (753s left) gem_ppgtt (flink-and-close-vma-leak)
[275.162158] Starting subtest: flink-and-close-vma-leak
[275.235527] Subtest flink-and-close-vma-leak: SUCCESS (0.073s)
[275.430823] [043/130] (752s left) kms_cursor_crc (cursor-sliding-128x42)
[275.822522] Starting subtest: cursor-sliding-128x42
[275.828135] Starting dynamic subtest: pipe-A-DP-3
[280.331478] Dynamic subtest pipe-A-DP-3: SUCCESS (4.502s)
[280.381322] Starting dynamic subtest: pipe-D-DP-3
[284.742079] Dynamic subtest pipe-D-DP-3: SUCCESS (4.370s)
[284.743099] Subtest cursor-sliding-128x42: SUCCESS (8.917s)
[285.186616] [044/130] (743s left) kms_atomic_transition (modeset-transition-nonblocking)
[285.378105] Starting subtest: modeset-transition-nonblocking
[285.378894] Starting dynamic subtest: 1x-outputs
[287.990443] Dynamic subtest 1x-outputs: SUCCESS (2.611s)
[287.992488] Subtest modeset-transition-nonblocking: SUCCESS (2.613s)
[288.266381] [045/130] (740s left) kms_plane_alpha_blend (alpha-transparent-fb)
[288.450794] Starting subtest: alpha-transparent-fb
[288.717013] Starting dynamic subtest: pipe-A-DP-3
[289.217062] Dynamic subtest pipe-A-DP-3: SUCCESS (0.499s)
[289.235523] Starting dynamic subtest: pipe-D-DP-3
[289.793830] Dynamic subtest pipe-D-DP-3: SUCCESS (0.575s)
[289.794694] Subtest alpha-transparent-fb: SUCCESS (1.343s)
[290.120736] [046/130] (738s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[290.310479] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[290.312158] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[290.474376] [047/130] (738s left) syncobj_wait (wait-all-complex)
[290.555187] Starting subtest: wait-all-complex
[290.772174] Subtest wait-all-complex: SUCCESS (0.216s)
[290.955532] [048/130] (737s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu)
[291.140849] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu
[291.142487] Subtest fbcpsr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[291.340432] [049/130] (737s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs)
[291.524070] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs
[291.525791] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[291.845102] [050/130] (737s left) gem_exec_whisper (basic-fds-priority)
[291.930289] Starting subtest: basic-fds-priority
[314.687659] Subtest basic-fds-priority: SUCCESS (22.754s)
[314.974525] [051/130] (713s left) gem_wait (await)
[315.061563] Starting subtest: await
[315.062453] Starting dynamic subtest: all-engines
[316.189406] Dynamic subtest all-engines: SUCCESS (1.127s)
[316.203795] Starting dynamic subtest: rcs0
[317.254517] Dynamic subtest rcs0: SUCCESS (1.063s)
[317.270566] Starting dynamic subtest: bcs0
[318.314156] Dynamic subtest bcs0: SUCCESS (1.057s)
[318.328468] Starting dynamic subtest: vcs0
[319.373363] Dynamic subtest vcs0: SUCCESS (1.058s)
[319.401997] Starting dynamic subtest: vcs1
[320.437377] Dynamic subtest vcs1: SUCCESS (1.062s)
[320.457543] Starting dynamic subtest: vecs0
[321.501473] Dynamic subtest vecs0: SUCCESS (1.061s)
[321.521433] Starting dynamic subtest: vecs1
[322.563296] Dynamic subtest vecs1: SUCCESS (1.059s)
[322.583482] Starting dynamic subtest: ccs0
[323.625472] Dynamic subtest ccs0: SUCCESS (1.059s)
[323.627147] Subtest await: SUCCESS (8.564s)
[323.927191] [052/130] (705s left) kms_psr (pr-no-drrs)
[324.113592] Subtest pr-no-drrs: SKIP (0.000s)
[324.175911] [053/130] (704s left) kms_joiner (basic-max-non-joiner)
[324.382588] Starting subtest: basic-max-non-joiner
[324.384648] Subtest basic-max-non-joiner: SKIP (0.000s)
[324.515770] [054/130] (704s left) kms_vblank (query-idle-hang)
[324.699082] Starting subtest: query-idle-hang
[324.699983] Starting dynamic subtest: pipe-A-DP-3
[351.609314] Dynamic subtest pipe-A-DP-3: SUCCESS (26.909s)
[351.623935] Starting dynamic subtest: pipe-D-DP-3
[376.533826] Dynamic subtest pipe-D-DP-3: SUCCESS (24.919s)
[376.534885] Subtest query-idle-hang: SUCCESS (51.833s)
[376.830732] [055/130] (652s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[376.907175] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[376.908133] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[377.105207] [056/130] (652s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[377.545673] Starting subtest: cursor-rapid-movement-256x85
[377.550275] Starting dynamic subtest: pipe-A-DP-3
[377.997149] Dynamic subtest pipe-A-DP-3: SUCCESS (0.447s)
[378.046747] Starting dynamic subtest: pipe-D-DP-3
[378.419971] Dynamic subtest pipe-D-DP-3: SUCCESS (0.385s)
[378.420964] Subtest cursor-rapid-movement-256x85: SUCCESS (0.874s)
[378.796968] [057/130] (650s left) gem_lmem_swapping (verify-ccs)
[381.397017] Starting subtest: verify-ccs
[381.397828] Starting dynamic subtest: lmem0
[425.984204] Dynamic subtest lmem0: SUCCESS (44.594s)
[425.985299] Subtest verify-ccs: SUCCESS (44.595s)
[427.933348] [FACT gem_lmem_swapping (verify-ccs)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[427.934372] [FACT gem_lmem_swapping (verify-ccs)] deleted: kernel.kmod_is_loaded.i915: true
[427.936119] [058/130] (601s left) kms_universal_plane (cursor-fb-leak)
[429.617126] Starting subtest: cursor-fb-leak
[429.618052] Starting dynamic subtest: pipe-A-DP-3
[430.163551] Dynamic subtest pipe-A-DP-3: SUCCESS (0.546s)
[430.177766] Starting dynamic subtest: pipe-B-DP-3
[430.749226] Dynamic subtest pipe-B-DP-3: SUCCESS (0.581s)
[430.767213] Starting dynamic subtest: pipe-C-DP-3
[431.342725] Dynamic subtest pipe-C-DP-3: SUCCESS (0.590s)
[431.366632] Starting dynamic subtest: pipe-D-DP-3
[431.928253] Dynamic subtest pipe-D-DP-3: SUCCESS (0.580s)
[431.934224] Subtest cursor-fb-leak: SUCCESS (2.314s)
[432.396187] [FACT kms_universal_plane (cursor-fb-leak)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[432.398451] [FACT kms_universal_plane (cursor-fb-leak)] new: kernel.kmod_is_loaded.i915: true
[432.401454] [059/130] (597s left) kms_getfb (getfb-reject-nv12)
[432.590170] Starting subtest: getfb-reject-nv12
[432.591072] Subtest getfb-reject-nv12: SUCCESS (0.002s)
[432.801667] [060/130] (596s left) kms_lease (atomic-implicit-crtc)
[432.985430] Starting subtest: atomic-implicit-crtc
[432.987862] Starting dynamic subtest: pipe-A-DP-3
[432.992410] Dynamic subtest pipe-A-DP-3: SUCCESS (0.003s)
[433.004010] Starting dynamic subtest: pipe-B-DP-3
[433.008494] Dynamic subtest pipe-B-DP-3: SUCCESS (0.011s)
[433.019996] Starting dynamic subtest: pipe-C-DP-3
[433.024211] Dynamic subtest pipe-C-DP-3: SUCCESS (0.010s)
[433.035086] Starting dynamic subtest: pipe-D-DP-3
[433.039527] Dynamic subtest pipe-D-DP-3: SUCCESS (0.009s)
[433.040505] Subtest atomic-implicit-crtc: SUCCESS (0.040s)
[433.229573] [061/130] (596s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[433.423770] Starting subtest: flip-vs-dpms-on-nop-interruptible
[433.428469] Starting dynamic subtest: A-DP3
[434.525929] Dynamic subtest A-DP3: SUCCESS (1.097s)
[434.539318] Starting dynamic subtest: B-DP3
[435.568130] Dynamic subtest B-DP3: SUCCESS (1.041s)
[435.581530] Starting dynamic subtest: C-DP3
[436.616141] Dynamic subtest C-DP3: SUCCESS (1.046s)
[436.630746] Starting dynamic subtest: D-DP3
[437.652059] Dynamic subtest D-DP3: SUCCESS (1.032s)
[437.654334] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (4.230s)
[438.032895] [062/130] (591s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[438.215692] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[438.217998] Starting dynamic subtest: pipe-A-DP-3
[438.227071] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[438.237719] Starting dynamic subtest: pipe-B-DP-3
[438.246786] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[438.257279] Starting dynamic subtest: pipe-C-DP-3
[438.266164] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[438.276606] Starting dynamic subtest: pipe-D-DP-3
[438.286894] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[438.288932] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SKIP (0.006s)
[438.714891] [063/130] (591s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[438.902050] Starting subtest: fbc-modesetfrombusy
[440.204892] Subtest fbc-modesetfrombusy: SUCCESS (1.304s)
[440.421783] [064/130] (589s left) gem_create (busy-create)
[440.500400] Starting subtest: busy-create
[440.501329] Starting dynamic subtest: lmem0
[472.822321] Dynamic subtest lmem0: SUCCESS (32.323s)
[472.841973] Starting dynamic subtest: smem0
[505.074235] Dynamic subtest smem0: SUCCESS (32.251s)
[505.075180] Subtest busy-create: SUCCESS (64.577s)
[505.369075] [065/130] (524s left) kms_psr (fbc-pr-sprite-render)
[505.561382] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[505.614672] [066/130] (524s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[505.804106] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[505.805846] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[506.001326] [067/130] (524s left) gem_ctx_persistence (engines-queued)
[506.093173] Starting subtest: engines-queued
[506.094108] Starting dynamic subtest: rcs0
[506.185173] Dynamic subtest rcs0: SUCCESS (0.092s)
[506.196980] Starting dynamic subtest: bcs0
[506.258592] Dynamic subtest bcs0: SUCCESS (0.072s)
[506.298747] Starting dynamic subtest: vcs0
[506.342515] Dynamic subtest vcs0: SUCCESS (0.081s)
[506.370356] Starting dynamic subtest: vcs1
[506.386323] Dynamic subtest vcs1: SUCCESS (0.042s)
[506.405927] Starting dynamic subtest: vecs0
[506.459499] Dynamic subtest vecs0: SUCCESS (0.071s)
[506.483825] Starting dynamic subtest: vecs1
[506.496344] Dynamic subtest vecs1: SUCCESS (0.035s)
[506.516754] Starting dynamic subtest: ccs0
[506.700228] Dynamic subtest ccs0: SUCCESS (0.202s)
[506.701213] Subtest engines-queued: SUCCESS (0.608s)
[506.918397] [068/130] (523s left) gem_sync (basic-each)
[507.006336] Starting subtest: basic-each
[509.162018] Subtest basic-each: SUCCESS (2.156s)
[509.450582] [069/130] (520s left) gem_render_copy (x-tiled)
[509.544383] Starting subtest: x-tiled
[509.545293] Starting dynamic subtest: smem
[509.652322] Dynamic subtest smem: SUCCESS (0.107s)
[509.663641] Starting dynamic subtest: lmem0
[510.989844] Dynamic subtest lmem0: SUCCESS (1.336s)
[510.990800] Subtest x-tiled: SUCCESS (1.446s)
[511.269461] [070/130] (519s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[511.352313] Starting subtest: yf-tiled-ccs-to-x-tiled
[511.354285] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[511.593146] [071/130] (518s left) kms_flip (basic-flip-vs-wf_vblank)
[511.775785] Starting subtest: basic-flip-vs-wf_vblank
[511.780424] Starting dynamic subtest: A-DP3
[513.062147] Dynamic subtest A-DP3: SUCCESS (1.282s)
[513.077418] Starting dynamic subtest: B-DP3
[514.110322] Dynamic subtest B-DP3: SUCCESS (1.046s)
[514.123711] Starting dynamic subtest: C-DP3
[515.157369] Dynamic subtest C-DP3: SUCCESS (1.046s)
[515.171112] Starting dynamic subtest: D-DP3
[516.209370] Dynamic subtest D-DP3: SUCCESS (1.051s)
[516.211578] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.436s)
[516.593884] [072/130] (513s left) gem_exec_reloc (basic-gtt-wc-active)
[516.678380] Subtest basic-gtt-wc-active: SKIP (0.000s)
[516.752801] [073/130] (513s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[516.936866] Starting subtest: async-flip-with-page-flip-events-tiled
[517.162152] Starting dynamic subtest: pipe-A-DP-3-4
[519.426541] Dynamic subtest pipe-A-DP-3-4: SUCCESS (2.264s)
[519.437867] Starting dynamic subtest: pipe-A-DP-3-x
[521.608514] Dynamic subtest pipe-A-DP-3-x: SUCCESS (2.181s)
[521.851769] Starting dynamic subtest: pipe-B-DP-3-4
[524.070573] Dynamic subtest pipe-B-DP-3-4: SUCCESS (2.230s)
[524.088785] Starting dynamic subtest: pipe-B-DP-3-x
[526.236181] Dynamic subtest pipe-B-DP-3-x: SUCCESS (2.164s)
[526.425347] Starting dynamic subtest: pipe-C-DP-3-4
[528.640888] Dynamic subtest pipe-C-DP-3-4: SUCCESS (2.228s)
[528.651901] Starting dynamic subtest: pipe-C-DP-3-x
[530.805852] Dynamic subtest pipe-C-DP-3-x: SUCCESS (2.164s)
[530.989117] Starting dynamic subtest: pipe-D-DP-3-4
[533.207375] Dynamic subtest pipe-D-DP-3-4: SUCCESS (2.232s)
[533.219159] Starting dynamic subtest: pipe-D-DP-3-x
[535.372831] Dynamic subtest pipe-D-DP-3-x: SUCCESS (2.164s)
[535.373713] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (18.437s)
[535.907832] [074/130] (494s left) gem_softpin (allocator-basic-reserve)
[535.987980] Starting subtest: allocator-basic-reserve
[536.211104] Subtest allocator-basic-reserve: SUCCESS (0.223s)
[536.438943] [075/130] (494s left) perf_pmu (pmu-read)
[536.507391] Starting subtest: pmu-read
[536.511208] Subtest pmu-read: SUCCESS (0.004s)
[536.724612] [076/130] (494s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[536.916883] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[536.918504] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[537.123880] [077/130] (493s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[537.310022] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[537.311611] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[537.508413] [078/130] (493s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[537.590464] Starting subtest: single-wait-for-submit-available-submitted
[537.591367] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s)
[537.791353] [079/130] (493s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[537.978895] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[537.980606] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[538.173869] [080/130] (492s left) gem_render_copy (yf-tiled-to-vebox-linear)
[538.259484] Starting subtest: yf-tiled-to-vebox-linear
[538.261538] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[538.557832] [081/130] (492s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[539.285177] Starting subtest: syncobj-stationary-timeline-chain-engines
[539.464840] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.181s)
[539.811773] [082/130] (491s left) kms_psr (fbc-pr-primary-mmap-gtt)
[539.999167] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[540.067416] [083/130] (491s left) gem_mmap_wc (copy)
[540.141111] Subtest copy: SKIP (0.000s)
[540.223287] [084/130] (491s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[540.409710] Starting subtest: plane-upscale-factor-0-25-with-rotation
[540.410561] Starting dynamic subtest: pipe-A
[540.789264] Dynamic subtest pipe-A: SUCCESS (0.379s)
[540.817155] Starting dynamic subtest: pipe-B
[541.272610] Dynamic subtest pipe-B: SUCCESS (0.481s)
[541.304808] Starting dynamic subtest: pipe-C
[541.750385] Dynamic subtest pipe-C: SUCCESS (0.475s)
[541.769922] Starting dynamic subtest: pipe-D
[542.214514] Dynamic subtest pipe-D: SUCCESS (0.462s)
[542.215632] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (1.806s)
[542.585385] [085/130] (488s left) gem_exec_schedule (preemptive-hang)
[542.809561] Starting subtest: preemptive-hang
[542.811464] Starting dynamic subtest: rcs0
[552.161372] Dynamic subtest rcs0: SUCCESS (9.358s)
[552.173403] Starting dynamic subtest: bcs0
[561.114391] Dynamic subtest bcs0: SUCCESS (8.952s)
[561.126220] Starting dynamic subtest: vcs0
[570.150693] Dynamic subtest vcs0: SUCCESS (9.035s)
[570.162487] Starting dynamic subtest: vcs1
[579.111731] Dynamic subtest vcs1: SUCCESS (8.961s)
[579.123481] Starting dynamic subtest: vecs0
[588.133575] Dynamic subtest vecs0: SUCCESS (9.020s)
[588.145381] Starting dynamic subtest: vecs1
[597.156437] Dynamic subtest vecs1: SUCCESS (9.022s)
[597.168317] Starting dynamic subtest: ccs0
[606.100998] Dynamic subtest ccs0: SUCCESS (8.944s)
[606.101889] Subtest preemptive-hang: SUCCESS (63.301s)
[606.430521] [086/130] (425s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs)
[606.628365] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs
[606.629235] Starting dynamic subtest: pipe-A-DP-3
[606.637430] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[606.648900] Starting dynamic subtest: pipe-B-DP-3
[606.657110] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[606.668305] Starting dynamic subtest: pipe-C-DP-3
[606.676465] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[606.687644] Starting dynamic subtest: pipe-D-DP-3
[606.697519] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[606.699341] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.009s)
[607.127925] [087/130] (424s left) gem_exec_suspend (basic-s3)
[607.213266] Starting subtest: basic-S3
[607.214193] Starting dynamic subtest: smem
[629.946753] Dynamic subtest smem: SUCCESS (7.221s)
[629.960413] Starting dynamic subtest: lmem0
[652.208002] Dynamic subtest lmem0: SUCCESS (7.256s)
[652.208974] Subtest basic-S3: SUCCESS (14.479s)
[652.523655] [088/130] (379s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[652.720500] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[652.722219] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[652.930043] [089/130] (378s left) gem_huc_copy (huc-copy)
[653.044157] Starting subtest: huc-copy
[653.049957] Subtest huc-copy: SUCCESS (0.006s)
[653.281479] [090/130] (378s left) kms_flip (flip-vs-expired-vblank)
[653.472807] Starting subtest: flip-vs-expired-vblank
[653.477560] Starting dynamic subtest: A-DP3
[661.328768] Dynamic subtest A-DP3: SUCCESS (7.851s)
[661.344802] Starting dynamic subtest: B-DP3
[669.100090] Dynamic subtest B-DP3: SUCCESS (7.769s)
[669.116486] Starting dynamic subtest: C-DP3
[676.867778] Dynamic subtest C-DP3: SUCCESS (7.763s)
[676.881738] Starting dynamic subtest: D-DP3
[684.634244] Dynamic subtest D-DP3: SUCCESS (7.765s)
[684.636547] Subtest flip-vs-expired-vblank: SUCCESS (31.163s)
[684.989287] [091/130] (347s left) i915_pm_rc6_residency (rc6-fence)
[685.065643] Starting subtest: rc6-fence
[685.085074] Starting dynamic subtest: gt0
[709.600399] Dynamic subtest gt0: SUCCESS (24.514s)
[709.605197] Subtest rc6-fence: SUCCESS (24.537s)
[709.779403] [092/130] (322s left) kms_plane (plane-position-hole)
[709.964657] Starting subtest: plane-position-hole
[710.408150] Starting dynamic subtest: pipe-A-plane-1
[710.867616] Dynamic subtest pipe-A-plane-1: SUCCESS (0.461s)
[710.882847] Starting dynamic subtest: pipe-A-plane-2
[711.306096] Dynamic subtest pipe-A-plane-2: SUCCESS (0.437s)
[711.323046] Starting dynamic subtest: pipe-A-plane-3
[711.752853] Dynamic subtest pipe-A-plane-3: SUCCESS (0.445s)
[711.767924] Starting dynamic subtest: pipe-A-plane-4
[712.207820] Dynamic subtest pipe-A-plane-4: SUCCESS (0.454s)
[712.223470] Starting dynamic subtest: pipe-A-plane-5
[712.230837] Dynamic subtest pipe-A-plane-5: SUCCESS (0.021s)
[712.570715] Starting dynamic subtest: pipe-B-plane-1
[712.975990] Dynamic subtest pipe-B-plane-1: SUCCESS (0.417s)
[712.989180] Starting dynamic subtest: pipe-B-plane-2
[713.390923] Dynamic subtest pipe-B-plane-2: SUCCESS (0.414s)
[713.403752] Starting dynamic subtest: pipe-B-plane-3
[713.790478] Dynamic subtest pipe-B-plane-3: SUCCESS (0.398s)
[713.803334] Starting dynamic subtest: pipe-B-plane-4
[714.226249] Dynamic subtest pipe-B-plane-4: SUCCESS (0.435s)
[714.238876] Starting dynamic subtest: pipe-B-plane-5
[714.246331] Dynamic subtest pipe-B-plane-5: SUCCESS (0.019s)
[714.247152] Subtest plane-position-hole: SUCCESS (4.282s)
[714.587225] [093/130] (317s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[714.770800] Starting subtest: random-ccs-data-yf-tiled-ccs
[714.771654] Starting dynamic subtest: pipe-A-DP-3
[714.780763] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[714.793525] Starting dynamic subtest: pipe-B-DP-3
[714.802635] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[714.814839] Starting dynamic subtest: pipe-C-DP-3
[714.823686] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[714.835832] Starting dynamic subtest: pipe-D-DP-3
[714.846737] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[714.848779] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.007s)
[715.262301] [094/130] (316s left) i915_hangman (engine-engine-error)
[715.352654] Starting subtest: engine-engine-error
[715.353551] Starting dynamic subtest: rcs0
[716.185126] Dynamic subtest rcs0: SUCCESS (0.832s)
[716.201522] Starting dynamic subtest: bcs0
[716.990730] Dynamic subtest bcs0: SUCCESS (0.804s)
[717.005568] Starting dynamic subtest: vcs0
[717.780113] Dynamic subtest vcs0: SUCCESS (0.788s)
[717.798394] Starting dynamic subtest: vcs1
[718.639076] Dynamic subtest vcs1: SUCCESS (0.857s)
[718.670226] Starting dynamic subtest: vecs0
[719.445715] Dynamic subtest vecs0: SUCCESS (0.805s)
[719.460598] Starting dynamic subtest: vecs1
[720.229862] Dynamic subtest vecs1: SUCCESS (0.783s)
[720.245641] Starting dynamic subtest: ccs0
[721.062859] Dynamic subtest ccs0: SUCCESS (0.832s)
[721.063887] Subtest engine-engine-error: SUCCESS (5.711s)
[721.295803] [095/130] (311s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[721.491503] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[721.493238] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[721.683427] [096/130] (310s left) gem_pwrite (basic-exhaustion)
[721.765535] Subtest basic-exhaustion: SKIP (0.000s)
[721.843031] [097/130] (310s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[721.922724] Starting subtest: etime-single-wait-available-unsubmitted
[722.030659] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.106s)
[722.212855] [098/130] (310s left) kms_prime (basic-crc-vgem)
[722.400861] Subtest basic-crc-vgem: SKIP (0.000s)
[722.619400] [099/130] (310s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[722.806902] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[722.809322] Starting dynamic subtest: pipe-A-valid-mode
[722.888674] Dynamic subtest pipe-A-valid-mode: SKIP (0.078s)
[722.890620] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.080s)
[723.142843] [100/130] (309s left) gem_exec_balancer (invalid-bonds)
[723.229938] Starting subtest: invalid-bonds
[723.231901] Subtest invalid-bonds: SKIP (0.000s)
[723.634587] [101/130] (309s left) gem_exec_balancer (sliced)
[723.721601] Starting subtest: sliced
[723.723775] Subtest sliced: SKIP (0.000s)
[724.137866] [102/130] (308s left) gem_exec_parallel (basic)
[724.227318] Starting subtest: basic
[724.228313] Starting dynamic subtest: rcs0
[725.751568] Dynamic subtest rcs0: SUCCESS (1.524s)
[725.766776] Starting dynamic subtest: bcs0
[727.216642] Dynamic subtest bcs0: SUCCESS (1.464s)
[727.232287] Starting dynamic subtest: vcs0
[728.700877] Dynamic subtest vcs0: SUCCESS (1.483s)
[728.717942] Starting dynamic subtest: vcs1
[730.211459] Dynamic subtest vcs1: SUCCESS (1.509s)
[730.227510] Starting dynamic subtest: vecs0
[731.664635] Dynamic subtest vecs0: SUCCESS (1.452s)
[731.680448] Starting dynamic subtest: vecs1
[733.132683] Dynamic subtest vecs1: SUCCESS (1.467s)
[733.150988] Starting dynamic subtest: ccs0
[734.610458] Dynamic subtest ccs0: SUCCESS (1.477s)
[734.611487] Subtest basic: SUCCESS (10.384s)
[734.940245] [103/130] (298s left) prime_busy (after)
[735.024894] Starting subtest: after
[735.029840] Starting dynamic subtest: rcs0
[735.092293] Dynamic subtest rcs0: SUCCESS (0.062s)
[735.104910] Starting dynamic subtest: bcs0
[735.145272] Dynamic subtest bcs0: SUCCESS (0.052s)
[735.166489] Starting dynamic subtest: vcs0
[735.185095] Dynamic subtest vcs0: SUCCESS (0.038s)
[735.207235] Starting dynamic subtest: vcs1
[735.225061] Dynamic subtest vcs1: SUCCESS (0.038s)
[735.246565] Starting dynamic subtest: vecs0
[735.264832] Dynamic subtest vecs0: SUCCESS (0.038s)
[735.282097] Starting dynamic subtest: vecs1
[735.305868] Dynamic subtest vecs1: SUCCESS (0.040s)
[735.322967] Starting dynamic subtest: ccs0
[735.346939] Dynamic subtest ccs0: SUCCESS (0.040s)
[735.461081] Subtest after: SUCCESS (0.435s)
[735.674369] [104/130] (297s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[735.868271] Starting subtest: y-tiled-64bpp-rotate-0
[735.869852] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[736.060262] [105/130] (297s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[736.251513] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[736.253232] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[736.460208] [106/130] (296s left) gem_mmap_wc (read-write-distinct)
[736.537544] Subtest read-write-distinct: SKIP (0.000s)
[736.602699] [107/130] (296s left) gem_ctx_sseu (engines)
[736.684534] Subtest engines: SKIP (0.000s)
[736.801266] [108/130] (296s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[736.878789] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[736.981424] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.102s)
[737.123732] [109/130] (296s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[737.307652] Starting subtest: basic-flip-before-cursor-atomic
[738.349805] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.041s)
[738.661130] [110/130] (294s left) syncobj_wait (single-wait-all-signaled)
[738.738820] Starting subtest: single-wait-all-signaled
[738.739726] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[738.951839] [111/130] (294s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[739.148749] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[739.895274] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.746s)
[740.180482] [112/130] (293s left) perf (gen12-unprivileged-single-ctx-counters)
[740.595676] Starting subtest: gen12-unprivileged-single-ctx-counters
[740.596555] Starting dynamic subtest: rcs0
[740.691646] Dynamic subtest rcs0: SUCCESS (0.095s)
[740.692573] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.096s)
[740.759407] [113/130] (292s left) kms_psr (psr-cursor-blt)
[740.986625] Subtest psr-cursor-blt: SKIP (0.000s)
[741.057687] [114/130] (292s left) gem_ccs (ctrl-surf-copy)
[741.141258] Starting subtest: ctrl-surf-copy
[741.143549] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0
[741.199613] Dynamic subtest linear-compressed-compfmt0-smem-lmem0: SUCCESS (0.057s)
[741.212296] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0
[741.394684] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.194s)
[741.408726] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0
[741.421696] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0: SUCCESS (0.026s)
[741.435835] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0
[741.623095] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.200s)
[741.637471] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0
[741.649844] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0: SUCCESS (0.026s)
[741.664104] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0
[741.853077] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.202s)
[741.867548] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0
[741.881023] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0: SUCCESS (0.026s)
[741.894376] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0
[742.079904] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.198s)
[742.080828] Subtest ctrl-surf-copy: SUCCESS (0.939s)
[742.306989] [115/130] (291s left) kms_flip (2x-absolute-wf_vblank)
[742.487849] Starting subtest: 2x-absolute-wf_vblank
[742.503235] Subtest 2x-absolute-wf_vblank: SKIP (0.014s)
[742.698138] [116/130] (291s left) kms_pm_dc (dc3co-vpb-simulation)
[743.901636] Starting subtest: dc3co-vpb-simulation
[743.903384] Subtest dc3co-vpb-simulation: SKIP (0.000s)
[744.060511] [117/130] (289s left) i915_query (test-query-geometry-subslices)
[744.139826] Starting subtest: test-query-geometry-subslices
[744.140862] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[744.302904] [118/130] (289s left) kms_psr (fbc-psr-sprite-render)
[744.488937] Subtest fbc-psr-sprite-render: SKIP (0.000s)
[744.557737] [119/130] (289s left) gem_userptr_blits (sync-overlap)
[744.644630] Starting subtest: sync-overlap
[744.645551] Subtest sync-overlap: SUCCESS (0.000s)
[744.879786] [120/130] (289s left) prime_vgem (fence-read-hang)
[744.977588] Subtest fence-read-hang: SKIP (0.000s)
[745.180399] [121/130] (289s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[745.255654] Starting subtest: invalid-single-wait-all-unsubmitted
[745.256574] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[745.446309] [122/130] (288s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[745.640718] Starting subtest: yf-tiled-64bpp-rotate-270
[745.642509] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[745.845920] [123/130] (288s left) core_setmaster (master-drop-set-shared-fd)
[746.029706] Starting subtest: master-drop-set-shared-fd
[746.061088] Subtest master-drop-set-shared-fd: SUCCESS (0.032s)
[746.109939] [124/130] (288s left) gem_ctx_create (basic-files)
[746.196144] Starting subtest: basic-files
[748.208733] Subtest basic-files: SUCCESS (2.012s)
[748.739750] [125/130] (285s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[748.814524] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[748.890619] [126/130] (285s left) kms_color (ctm-blue-to-red)
[749.073647] Starting subtest: ctm-blue-to-red
[749.074540] Starting dynamic subtest: pipe-A-DP-3
[749.739005] Dynamic subtest pipe-A-DP-3: SUCCESS (0.664s)
[749.759644] Starting dynamic subtest: pipe-B-DP-3
[750.343387] Dynamic subtest pipe-B-DP-3: SUCCESS (0.603s)
[750.356666] Starting dynamic subtest: pipe-C-DP-3
[750.926793] Dynamic subtest pipe-C-DP-3: SUCCESS (0.583s)
[750.947772] Starting dynamic subtest: pipe-D-DP-3
[751.523372] Dynamic subtest pipe-D-DP-3: SUCCESS (0.595s)
[751.524266] Subtest ctm-blue-to-red: SUCCESS (2.451s)
[751.842188] [127/130] (282s left) gem_eio (in-flight-external)
[752.156880] Starting subtest: in-flight-external
[753.431661] Subtest in-flight-external: SUCCESS (1.275s)
[753.719459] [128/130] (281s left) kms_frontbuffer_tracking (fbc-2p-rte)
[753.919546] Starting subtest: fbc-2p-rte
[753.921131] Subtest fbc-2p-rte: SKIP (0.000s)
[754.062757] [129/130] (280s left) syncobj_wait (wait-all-for-submit-complex)
[754.356788] Starting subtest: wait-all-for-submit-complex
[754.570011] Subtest wait-all-for-submit-complex: SUCCESS (0.214s)
[754.709332] [130/130] (280s left) kms_properties (colorop-properties-atomic)
[755.110294] Starting subtest: colorop-properties-atomic
[755.112804] Starting dynamic subtest: pipe-A-DP-3
[755.282567] Dynamic subtest pipe-A-DP-3: SUCCESS (0.170s)
[755.296097] Starting dynamic subtest: pipe-B-DP-3
[755.465605] Dynamic subtest pipe-B-DP-3: SUCCESS (0.182s)
[755.482089] Starting dynamic subtest: pipe-C-DP-3
[755.653871] Dynamic subtest pipe-C-DP-3: SUCCESS (0.186s)
[755.667264] Starting dynamic subtest: pipe-D-DP-3
[755.838150] Dynamic subtest pipe-D-DP-3: SUCCESS (0.182s)
[755.838965] Subtest colorop-properties-atomic: SUCCESS (0.728s)
[756.172932] Closing watchdogs
results: parsing output: 0/ for test: kms_ccs
results: parsing output: 1/ for test: gem_fence_thrash
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_exec_parallel
results: parsing output: 4/ for test: gem_wait
results: parsing output: 5/ for test: gem_tiled_wb
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: i915_drm_fdinfo
results: parsing output: 9/ for test: gem_exec_reloc
results: parsing output: 10/ for test: gem_mmap_offset
results: parsing output: 11/ for test: kms_dp_aux_dev
results: parsing output: 12/ for test: gem_exec_params
results: parsing output: 13/ for test: vgem_basic
results: parsing output: 14/ for test: kms_getfb
results: parsing output: 15/ for test: kms_cursor_crc
results: parsing output: 16/ for test: kms_cursor_legacy
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: kms_dp_linktrain_fallback
results: parsing output: 20/ for test: core_debugfs
results: parsing output: 21/ for test: gem_ctx_param
results: parsing output: 22/ for test: vgem_basic
results: parsing output: 23/ for test: kms_psr
results: parsing output: 24/ for test: kms_getfb
results: parsing output: 25/ for test: kms_flip_scaled_crc
results: parsing output: 26/ for test: gem_exec_flush
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_plane_multiple
results: parsing output: 29/ for test: kms_ccs
results: parsing output: 30/ for test: gem_eio
results: parsing output: 31/ for test: gen7_exec_parse
results: parsing output: 32/ for test: gem_mmap_gtt
results: parsing output: 33/ for test: kms_chamelium_frames
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: gem_exec_schedule
results: parsing output: 36/ for test: kms_psr2_sf
results: parsing output: 37/ for test: gem_exec_schedule
results: parsing output: 38/ for test: kms_color
results: parsing output: 39/ for test: kms_big_fb
results: parsing output: 40/ for test: gem_eio
results: parsing output: 41/ for test: gem_ppgtt
results: parsing output: 42/ for test: kms_cursor_crc
results: parsing output: 43/ for test: kms_atomic_transition
results: parsing output: 44/ for test: kms_plane_alpha_blend
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: syncobj_wait
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_ccs
results: parsing output: 49/ for test: gem_exec_whisper
results: parsing output: 50/ for test: gem_wait
results: parsing output: 51/ for test: kms_psr
results: parsing output: 52/ for test: kms_joiner
results: parsing output: 53/ for test: kms_vblank
results: parsing output: 54/ for test: syncobj_timeline
results: parsing output: 55/ for test: kms_cursor_crc
results: parsing output: 56/ for test: gem_lmem_swapping
results: parsing output: 57/ for test: kms_universal_plane
results: parsing output: 58/ for test: kms_getfb
results: parsing output: 59/ for test: kms_lease
results: parsing output: 60/ for test: kms_flip
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_create
results: parsing output: 64/ for test: kms_psr
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_ctx_persistence
results: parsing output: 67/ for test: gem_sync
results: parsing output: 68/ for test: gem_render_copy
results: parsing output: 69/ for test: gem_render_copy
results: parsing output: 70/ for test: kms_flip
results: parsing output: 71/ for test: gem_exec_reloc
results: parsing output: 72/ for test: kms_async_flips
results: parsing output: 73/ for test: gem_softpin
results: parsing output: 74/ for test: perf_pmu
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: syncobj_timeline
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_render_copy
results: parsing output: 80/ for test: gem_exec_fence
results: parsing output: 81/ for test: kms_psr
results: parsing output: 82/ for test: gem_mmap_wc
results: parsing output: 83/ for test: kms_plane_scaling
results: parsing output: 84/ for test: gem_exec_schedule
results: parsing output: 85/ for test: kms_ccs
results: parsing output: 86/ for test: gem_exec_suspend
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_huc_copy
results: parsing output: 89/ for test: kms_flip
results: parsing output: 90/ for test: i915_pm_rc6_residency
results: parsing output: 91/ for test: kms_plane
results: parsing output: 92/ for test: kms_ccs
results: parsing output: 93/ for test: i915_hangman
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: gem_pwrite
results: parsing output: 96/ for test: syncobj_timeline
results: parsing output: 97/ for test: kms_prime
results: parsing output: 98/ for test: kms_flip_scaled_crc
results: parsing output: 99/ for test: gem_exec_balancer
results: parsing output: 100/ for test: gem_exec_balancer
results: parsing output: 101/ for test: gem_exec_parallel
results: parsing output: 102/ for test: prime_busy
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: gem_mmap_wc
results: parsing output: 106/ for test: gem_ctx_sseu
results: parsing output: 107/ for test: syncobj_timeline
results: parsing output: 108/ for test: kms_cursor_legacy
results: parsing output: 109/ for test: syncobj_wait
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: perf
results: parsing output: 112/ for test: kms_psr
results: parsing output: 113/ for test: gem_ccs
results: parsing output: 114/ for test: kms_flip
results: parsing output: 115/ for test: kms_pm_dc
results: parsing output: 116/ for test: i915_query
results: parsing output: 117/ for test: kms_psr
results: parsing output: 118/ for test: gem_userptr_blits
results: parsing output: 119/ for test: prime_vgem
results: parsing output: 120/ for test: syncobj_timeline
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: core_setmaster
results: parsing output: 123/ for test: gem_ctx_create
results: parsing output: 124/ for test: kms_pipe_b_c_ivb
results: parsing output: 125/ for test: kms_color
results: parsing output: 126/ for test: gem_eio
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: syncobj_wait
results: parsing output: 129/ for test: kms_properties
Done.