[59.292138] Initializing watchdogs
[59.292227]   /dev/watchdog0
[59.307924] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[59.312626] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.314823] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.318284] [001/154] (960s left) kms_rmfb (close-fd)
[59.438345] Starting subtest: close-fd
[59.440990] Starting dynamic subtest: pipe-A-eDP-1
[59.557441] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.120s)
[59.566573] Starting dynamic subtest: pipe-B-eDP-1
[60.736336] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.177s)
[60.745896] Starting dynamic subtest: pipe-C-eDP-1
[61.966837] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.230s)
[61.976728] Starting dynamic subtest: pipe-D-eDP-1
[63.113606] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.146s)
[63.115686] Subtest close-fd: SUCCESS (3.676s)
[64.325166] [002/154] (955s left) gem_exec_fence (syncobj-import)
[64.764929] Starting subtest: syncobj-import
[64.771032] Subtest syncobj-import: SUCCESS (0.005s)
[66.376298] [FACT gem_exec_fence (syncobj-import)] new: kernel.kmod_is_loaded.vgem: true
[66.379747] [003/154] (953s left) gem_exec_schedule (u-lateslice)
[66.455731] Starting subtest: u-lateslice
[66.458108] Starting dynamic subtest: rcs0
[66.467331] Dynamic subtest rcs0: SUCCESS (0.023s)
[66.475522] Starting dynamic subtest: bcs0
[66.485796] Dynamic subtest bcs0: SUCCESS (0.018s)
[66.493356] Starting dynamic subtest: vcs0
[66.503297] Dynamic subtest vcs0: SUCCESS (0.017s)
[66.510705] Starting dynamic subtest: vcs1
[66.522245] Dynamic subtest vcs1: SUCCESS (0.019s)
[66.529922] Starting dynamic subtest: vecs0
[66.541278] Dynamic subtest vecs0: SUCCESS (0.018s)
[66.548819] Starting dynamic subtest: ccs0
[66.558652] Dynamic subtest ccs0: SUCCESS (0.017s)
[66.560973] Subtest u-lateslice: SUCCESS (0.115s)
[68.361150] [004/154] (951s left) i915_pm_rpm (reg-read-ioctl)
[70.426833] Starting subtest: reg-read-ioctl
[72.725679] Subtest reg-read-ioctl: SUCCESS (2.302s)
[73.119102] [005/154] (946s left) gem_lmem_swapping (parallel-random)
[73.173824] Subtest parallel-random: SKIP (0.000s)
[73.227633] [006/154] (946s left) gem_ctx_persistence (engines-persistence)
[73.315821] Starting subtest: engines-persistence
[73.318346] Starting dynamic subtest: rcs0
[74.180195] Dynamic subtest rcs0: SUCCESS (0.864s)
[74.189750] Starting dynamic subtest: bcs0
[74.934788] Dynamic subtest bcs0: SUCCESS (0.754s)
[74.945783] Starting dynamic subtest: vcs0
[75.691236] Dynamic subtest vcs0: SUCCESS (0.755s)
[75.701636] Starting dynamic subtest: vcs1
[76.469819] Dynamic subtest vcs1: SUCCESS (0.778s)
[76.481251] Starting dynamic subtest: vecs0
[77.239217] Dynamic subtest vecs0: SUCCESS (0.768s)
[77.250764] Starting dynamic subtest: ccs0
[78.008060] Dynamic subtest ccs0: SUCCESS (0.768s)
[78.011207] Subtest engines-persistence: SUCCESS (4.693s)
[78.088173] [007/154] (941s left) kms_properties (colorop-properties-legacy)
[78.185801] Starting subtest: colorop-properties-legacy
[78.188131] Starting dynamic subtest: pipe-A-eDP-1
[78.542942] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.356s)
[78.554829] Starting dynamic subtest: pipe-B-eDP-1
[79.667873] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.125s)
[79.676891] Starting dynamic subtest: pipe-C-eDP-1
[80.719526] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.053s)
[80.729280] Starting dynamic subtest: pipe-D-eDP-1
[81.856348] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.134s)
[81.858781] Subtest colorop-properties-legacy: SUCCESS (3.671s)
[82.674214] [008/154] (937s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[82.783293] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[82.787105] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[82.885320] [009/154] (937s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[82.985345] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf
[82.989577] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[83.051745] [010/154] (937s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[83.150386] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu
[83.154482] Subtest psrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[83.285306] [011/154] (936s left) gem_exec_whisper (basic-contexts-forked-all)
[83.347617] Starting subtest: basic-contexts-forked-all
[104.118851] Subtest basic-contexts-forked-all: SUCCESS (20.766s)
[104.299509] [012/154] (916s left) prime_mmap (test_invalid_sync_flags)
[104.373087] Starting subtest: test_invalid_sync_flags
[104.375419] Starting dynamic subtest: test_invalid_sync_flags-smem
[104.377426] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[104.379427] Subtest test_invalid_sync_flags: SUCCESS (0.000s)
[104.467485] [013/154] (915s left) prime_vgem (wait)
[104.534818] Starting subtest: wait
[104.537242] Starting dynamic subtest: rcs0
[104.642334] Dynamic subtest rcs0: SUCCESS (0.107s)
[104.656530] Starting dynamic subtest: bcs0
[104.709921] Dynamic subtest bcs0: SUCCESS (0.067s)
[104.718500] Starting dynamic subtest: vcs0
[104.753308] Dynamic subtest vcs0: SUCCESS (0.043s)
[104.761721] Starting dynamic subtest: vcs1
[104.799794] Dynamic subtest vcs1: SUCCESS (0.045s)
[104.808179] Starting dynamic subtest: vecs0
[104.853082] Dynamic subtest vecs0: SUCCESS (0.053s)
[104.861605] Starting dynamic subtest: ccs0
[104.902920] Dynamic subtest ccs0: SUCCESS (0.050s)
[104.905302] Subtest wait: SUCCESS (0.369s)
[105.036438] [014/154] (915s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[105.141944] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[105.145877] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[105.235036] [015/154] (915s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-pwrite)
[105.349750] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-pwrite
[105.353169] Subtest psrhdr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[105.447414] [016/154] (915s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[105.559126] Starting subtest: y-tiled-8bpp-rotate-180
[105.562784] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[105.649553] [017/154] (914s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[105.737194] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[105.741016] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[105.834861] [018/154] (914s left) kms_psr (psr2-sprite-plane-onoff)
[105.931064] Starting subtest: psr2-sprite-plane-onoff
[105.933081] Starting dynamic subtest: eDP-1
[107.668710] Dynamic subtest eDP-1: SUCCESS (1.738s)
[107.671154] Subtest psr2-sprite-plane-onoff: SUCCESS (1.738s)
[108.526709] [019/154] (912s left) kms_cursor_crc (cursor-onscreen-64x21)
[108.725038] Starting subtest: cursor-onscreen-64x21
[108.771303] Subtest cursor-onscreen-64x21: SKIP (0.041s)
[109.014926] [020/154] (911s left) kms_frontbuffer_tracking (fbcpsrhdr-tiling-y)
[109.124025] Starting subtest: fbcpsrhdr-tiling-y
[109.128197] Subtest fbcpsrhdr-tiling-y: SKIP (0.000s)
[109.224879] [021/154] (911s left) syncobj_timeline (multi-wait-all-available-submitted)
[109.281935] Starting subtest: multi-wait-all-available-submitted
[109.284226] Subtest multi-wait-all-available-submitted: SUCCESS (0.001s)
[109.400163] [022/154] (911s left) gem_userptr_blits (unsync-unmap)
[109.455794] Subtest unsync-unmap: SKIP (0.000s)
[109.576515] [023/154] (911s left) gem_exec_params (invalid-bsd2-flag-on-render)
[109.626571] Starting subtest: invalid-bsd2-flag-on-render
[109.628155] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[109.742128] [024/154] (911s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[109.796428] Starting subtest: etime-multi-wait-all-submitted-signaled
[109.901879] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.103s)
[109.975604] [025/154] (910s left) kms_cursor_legacy (forked-bo)
[110.096239] Starting subtest: forked-bo
[110.098624] Starting dynamic subtest: pipe-A
[115.555249] Dynamic subtest pipe-A: SUCCESS (5.456s)
[115.568967] Starting dynamic subtest: pipe-B
[121.047045] Dynamic subtest pipe-B: SUCCESS (5.491s)
[121.067075] Starting dynamic subtest: pipe-C
[126.515395] Dynamic subtest pipe-C: SUCCESS (5.468s)
[126.528716] Starting dynamic subtest: pipe-D
[131.999346] Dynamic subtest pipe-D: SUCCESS (5.482s)
[132.012195] Starting dynamic subtest: all-pipes
[137.505764] Dynamic subtest all-pipes: SUCCESS (5.506s)
[137.508301] Subtest forked-bo: SUCCESS (27.407s)
[137.661666] [026/154] (883s left) gem_exec_params (larger-than-life-batch)
[137.729847] Starting subtest: larger-than-life-batch
[139.993354] Subtest larger-than-life-batch: SUCCESS (2.263s)
[141.357930] [027/154] (879s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[141.501948] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[141.506280] Subtest hdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[141.605580] [028/154] (879s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted)
[141.671857] Starting subtest: multi-wait-all-for-submit-unsubmitted
[141.782068] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.108s)
[141.869846] [029/154] (879s left) kms_getfb (getfb2-into-addfb2)
[141.973406] Starting subtest: getfb2-into-addfb2
[141.975721] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[142.073530] [030/154] (878s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[142.197047] Starting subtest: cursorB-vs-flipA-varying-size
[142.201641] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s)
[142.341416] [031/154] (878s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[142.442270] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[142.446826] Subtest hdr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[142.524561] [032/154] (878s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[142.644850] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[142.649392] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[142.789196] [033/154] (878s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[142.894464] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[142.897813] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[142.989823] [034/154] (878s left) perf_pmu (rc6)
[143.030359] Starting subtest: rc6
[143.032215] Starting dynamic subtest: gt0
[149.410486] Dynamic subtest gt0: SUCCESS (6.377s)
[149.423029] Starting dynamic subtest: runtime-pm-gt0
[157.190349] Dynamic subtest runtime-pm-gt0: SUCCESS (7.777s)
[157.200711] Starting dynamic subtest: runtime-pm-long-gt0
[169.696101] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.504s)
[169.708228] Starting dynamic subtest: other-idle-gt0
[176.039217] Dynamic subtest other-idle-gt0: SUCCESS (6.342s)
[176.051763] Starting dynamic subtest: gt1
[182.379745] Dynamic subtest gt1: SUCCESS (6.339s)
[182.392095] Starting dynamic subtest: runtime-pm-gt1
[189.805721] Dynamic subtest runtime-pm-gt1: SUCCESS (7.425s)
[189.817081] Starting dynamic subtest: runtime-pm-long-gt1
[202.227930] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.421s)
[202.240526] Starting dynamic subtest: other-idle-gt1
[208.575952] Dynamic subtest other-idle-gt1: SUCCESS (6.347s)
[208.579360] Subtest rc6: SUCCESS (65.541s)
[209.714952] [035/154] (811s left) kms_psr (psr2-basic)
[209.807111] Starting subtest: psr2-basic
[209.809477] Starting dynamic subtest: eDP-1
[211.402044] Dynamic subtest eDP-1: SUCCESS (1.594s)
[211.403950] Subtest psr2-basic: SUCCESS (1.594s)
[212.187374] [036/154] (809s left) kms_rotation_crc (multiplane-rotation)
[212.288346] Starting subtest: multiplane-rotation
[229.757870] Subtest multiplane-rotation: SUCCESS (17.471s)
[229.849698] [037/154] (791s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-blt)
[229.946677] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-blt
[229.949886] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[230.015059] [038/154] (791s left) kms_flip (absolute-wf_vblank-interruptible)
[230.109484] Starting subtest: absolute-wf_vblank-interruptible
[230.111173] Starting dynamic subtest: A-eDP1
[238.864651] Dynamic subtest A-eDP1: SUCCESS (8.753s)
[238.880390] Starting dynamic subtest: B-eDP1
[247.602060] Dynamic subtest B-eDP1: SUCCESS (8.731s)
[247.616658] Starting dynamic subtest: C-eDP1
[256.318453] Dynamic subtest C-eDP1: SUCCESS (8.718s)
[256.330692] Starting dynamic subtest: D-eDP1
[265.053372] Dynamic subtest D-eDP1: SUCCESS (8.733s)
[265.059467] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.950s)
[266.246845] [039/154] (755s left) gem_flink_basic (flink-lifetime)
[266.301892] Starting subtest: flink-lifetime
[266.304304] Subtest flink-lifetime: SUCCESS (0.003s)
[266.388391] [040/154] (755s left) gen9_exec_parse (bb-secure)
[266.453576] Subtest bb-secure: SKIP (0.000s)
[266.526957] [041/154] (754s left) gen7_exec_parse (basic-allocation)
[266.596326] Subtest basic-allocation: SKIP (0.000s)
[266.654826] [042/154] (754s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[266.754718] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-mmap-wc
[266.758754] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[266.835350] [043/154] (754s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[266.937753] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[266.942293] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[267.011836] [044/154] (754s left) kms_flip (flip-vs-wf_vblank-interruptible)
[267.097182] Starting subtest: flip-vs-wf_vblank-interruptible
[267.099484] Starting dynamic subtest: A-eDP1
[269.012117] Dynamic subtest A-eDP1: SUCCESS (1.914s)
[269.023346] Starting dynamic subtest: B-eDP1
[270.948068] Dynamic subtest B-eDP1: SUCCESS (1.935s)
[270.959515] Starting dynamic subtest: C-eDP1
[272.862158] Dynamic subtest C-eDP1: SUCCESS (1.912s)
[272.874298] Starting dynamic subtest: D-eDP1
[274.801601] Dynamic subtest D-eDP1: SUCCESS (1.938s)
[274.804092] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.708s)
[276.002984] [045/154] (745s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-pwrite)
[276.104531] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-pwrite
[276.108509] Subtest hdr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[276.179725] [046/154] (745s left) gem_ctx_persistence (hang)
[276.228071] Starting subtest: hang
[276.232297] Subtest hang: SKIP (0.000s)
[276.313658] [047/154] (745s left) kms_properties (get_properties-sanity-non-atomic)
[276.408463] Starting subtest: get_properties-sanity-non-atomic
[276.410697] Subtest get_properties-sanity-non-atomic: SUCCESS (0.001s)
[276.457533] [048/154] (745s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[276.555241] Starting subtest: plane-lut1d-ctm3x4-lut1d
[276.722910] Starting dynamic subtest: pipe-A-plane-0
[276.911678] Dynamic subtest pipe-A-plane-0: SUCCESS (0.189s)
[276.921157] Starting dynamic subtest: pipe-A-plane-1
[277.044795] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s)
[277.054265] Starting dynamic subtest: pipe-A-plane-2
[277.177959] Dynamic subtest pipe-A-plane-2: SUCCESS (0.133s)
[278.401684] Starting dynamic subtest: pipe-B-plane-0
[278.538451] Dynamic subtest pipe-B-plane-0: SUCCESS (0.144s)
[278.550685] Starting dynamic subtest: pipe-B-plane-1
[278.719442] Dynamic subtest pipe-B-plane-1: SUCCESS (0.177s)
[278.728896] Starting dynamic subtest: pipe-B-plane-2
[278.872363] Dynamic subtest pipe-B-plane-2: SUCCESS (0.155s)
[280.049169] Starting dynamic subtest: pipe-C-plane-0
[280.174060] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[280.184230] Starting dynamic subtest: pipe-C-plane-1
[280.318961] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[280.330259] Starting dynamic subtest: pipe-C-plane-2
[280.463344] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[281.683818] Starting dynamic subtest: pipe-D-plane-0
[281.808339] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s)
[281.818313] Starting dynamic subtest: pipe-D-plane-1
[281.941609] Dynamic subtest pipe-D-plane-1: SUCCESS (0.132s)
[281.951271] Starting dynamic subtest: pipe-D-plane-2
[282.074849] Dynamic subtest pipe-D-plane-2: SUCCESS (0.133s)
[282.364313] Subtest plane-lut1d-ctm3x4-lut1d: SUCCESS (5.808s)
[283.239413] [049/154] (738s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[283.293515] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[283.398054] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.104s)
[283.454214] [050/154] (738s left) vgem_basic (debugfs)
[283.496514] Starting subtest: debugfs
[283.498954] Subtest debugfs: SUCCESS (0.001s)
[283.535411] [051/154] (738s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-move)
[283.627749] Starting subtest: psrhdr-1p-primscrn-cur-indfb-move
[283.632192] Subtest psrhdr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[283.710211] [052/154] (738s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[283.806066] Starting subtest: yf-tiled-64bpp-rotate-180
[283.810627] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[283.877289] [053/154] (738s left) kms_joiner (invalid-modeset-force-big-joiner)
[283.973171] Starting subtest: invalid-modeset-force-big-joiner
[283.977694] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[284.017723] [054/154] (737s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[284.119260] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[284.124666] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[285.277865] [055/154] (736s left) gem_pxp (reject-modify-context-protection-on)
[285.400155] Starting subtest: reject-modify-context-protection-on
[285.402772] Subtest reject-modify-context-protection-on: SUCCESS (0.002s)
[285.495738] [056/154] (736s left) kms_lease (possible-crtcs-filtering)
[285.585833] Starting subtest: possible-crtcs-filtering
[285.590430] Subtest possible-crtcs-filtering: SUCCESS (0.005s)
[285.677473] [057/154] (736s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-onoff)
[285.780967] Starting subtest: fbchdr-1p-primscrn-spr-indfb-onoff
[285.785204] Subtest fbchdr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[285.863608] [058/154] (736s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[285.917815] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[285.995069] [059/154] (736s left) gem_exec_create (forked)
[286.064763] Starting subtest: forked
[286.067280] Starting dynamic subtest: smem
[307.324045] Dynamic subtest smem: SUCCESS (21.255s)
[307.327041] Subtest forked: SUCCESS (21.258s)
[307.485792] [060/154] (714s left) vgem_basic (unload)
[307.523283] Starting subtest: unload
[336.593759] Subtest unload: SUCCESS (29.068s)
[336.671916] [061/154] (685s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[336.777162] Starting subtest: x-tiled-8bpp-rotate-180
[337.947772] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.171s)
[338.036377] [062/154] (684s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-render)
[338.139598] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-render
[338.143246] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[338.214632] [063/154] (684s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-mmap-wc)
[338.303354] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-mmap-wc
[338.306962] Subtest hdr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[338.371468] [064/154] (684s left) kms_force_connector_basic (force-load-detect)
[338.448383] Starting subtest: force-load-detect
[338.452342] Subtest force-load-detect: SKIP (0.000s)
[338.539999] [065/154] (683s left) syncobj_wait (single-wait-all-signaled)
[338.593704] Starting subtest: single-wait-all-signaled
[338.595513] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[338.678409] [066/154] (683s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[338.780974] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[338.784301] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[338.857947] [067/154] (683s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[338.947368] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[338.959172] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.010s)
[339.014178] [068/154] (683s left) kms_psr2_su (page_flip-nv12)
[339.073370] Subtest page_flip-NV12: SKIP (0.000s)
[339.138715] [069/154] (683s left) syncobj_timeline (wait-all-delayed-signal)
[339.186174] Starting subtest: wait-all-delayed-signal
[339.287777] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[339.343488] [070/154] (683s left) gem_reg_read (timestamp-monotonic)
[339.399047] Starting subtest: timestamp-monotonic
[344.014055] Subtest timestamp-monotonic: SUCCESS (4.615s)
[344.066855] [071/154] (678s left) gem_ctx_shared (q-smoketest)
[344.132529] Starting subtest: Q-smoketest
[344.134671] Starting dynamic subtest: rcs0
[349.670294] Dynamic subtest rcs0: SUCCESS (5.491s)
[349.681595] Starting dynamic subtest: bcs0
[355.166585] Dynamic subtest bcs0: SUCCESS (5.496s)
[355.178021] Starting dynamic subtest: vcs0
[360.654291] Dynamic subtest vcs0: SUCCESS (5.486s)
[360.664176] Starting dynamic subtest: vcs1
[366.137145] Dynamic subtest vcs1: SUCCESS (5.479s)
[366.154269] Starting dynamic subtest: vecs0
[371.628378] Dynamic subtest vecs0: SUCCESS (5.489s)
[371.640164] Starting dynamic subtest: ccs0
[377.118306] Dynamic subtest ccs0: SUCCESS (5.488s)
[377.120601] Subtest Q-smoketest: SUCCESS (32.937s)
[377.234244] [072/154] (645s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-pwrite)
[377.341052] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-pwrite
[377.345611] Subtest hdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[377.422990] [073/154] (645s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[377.516270] Starting subtest: fbc-farfromfence-mmap-gtt
[377.520502] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[377.598665] [074/154] (645s left) i915_selftest (perf)
[381.001506] Starting subtest: perf
[381.003998] Starting dynamic subtest: engine_cs
[383.837663] Dynamic subtest engine_cs: SUCCESS (2.834s)
[383.852796] Starting dynamic subtest: request
[391.113175] Dynamic subtest request: SUCCESS (7.273s)
[391.123332] Starting dynamic subtest: migrate
[395.500759] Dynamic subtest migrate: SUCCESS (4.385s)
[395.510475] Starting dynamic subtest: region
[399.736544] Dynamic subtest region: SUCCESS (4.234s)
[399.739406] Subtest perf: SUCCESS (18.734s)
[399.770600] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[399.771305] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[399.774437] [075/154] (623s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[401.275278] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[401.279344] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[401.337819] [FACT kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[401.339071] [FACT kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)] new: kernel.kmod_is_loaded.i915: true
[401.343231] [076/154] (621s left) kms_psr (fbc-psr2-cursor-plane-move)
[401.446359] Starting subtest: fbc-psr2-cursor-plane-move
[401.448599] Starting dynamic subtest: eDP-1
[401.452757] Dynamic subtest eDP-1: SKIP (0.000s)
[401.456922] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s)
[401.492805] [077/154] (621s left) kms_atomic_transition (modeset-transition)
[401.576262] Starting subtest: modeset-transition
[401.578208] Starting dynamic subtest: 1x-outputs
[412.709622] Dynamic subtest 1x-outputs: SUCCESS (11.134s)
[412.712071] Subtest modeset-transition: SUCCESS (11.135s)
[413.549990] [078/154] (609s left) gem_eio (hibernate)
[413.684296] Starting subtest: hibernate
[428.209419] Subtest hibernate: SUCCESS (14.525s)
[436.354263] [079/154] (594s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[436.508725] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt
[436.513158] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[436.573490] [080/154] (594s left) kms_plane_cursor (overlay)
[436.665275] Starting subtest: overlay
[436.669530] Starting dynamic subtest: pipe-A-eDP-1-size-64
[439.116062] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.451s)
[439.177417] Starting dynamic subtest: pipe-A-eDP-1-size-128
[441.639933] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.471s)
[441.700493] Starting dynamic subtest: pipe-A-eDP-1-size-256
[444.128887] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.439s)
[444.489408] Starting dynamic subtest: pipe-B-eDP-1-size-64
[447.602685] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.124s)
[447.663313] Starting dynamic subtest: pipe-B-eDP-1-size-128
[450.136678] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.482s)
[450.197558] Starting dynamic subtest: pipe-B-eDP-1-size-256
[452.650080] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.462s)
[453.003204] Starting dynamic subtest: pipe-C-eDP-1-size-64
[455.824889] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.833s)
[455.863575] Starting dynamic subtest: pipe-C-eDP-1-size-128
[457.913455] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.058s)
[457.952383] Starting dynamic subtest: pipe-C-eDP-1-size-256
[460.035605] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.092s)
[460.364374] Starting dynamic subtest: pipe-D-eDP-1-size-64
[463.136701] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.783s)
[463.176229] Starting dynamic subtest: pipe-D-eDP-1-size-128
[465.281312] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.114s)
[465.321902] Starting dynamic subtest: pipe-D-eDP-1-size-256
[467.381084] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.070s)
[467.700961] Subtest overlay: SUCCESS (31.036s)
[468.497942] [081/154] (562s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[468.601995] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[468.606017] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[468.667563] [082/154] (562s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[468.768484] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[476.408913] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.645s)
[476.503289] [083/154] (554s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[476.604560] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[477.593600] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (0.990s)
[477.696208] [084/154] (553s left) kms_content_protection (dp-mst-lic-type-0)
[477.846605] Starting subtest: dp-mst-lic-type-0
[477.850536] Subtest dp-mst-lic-type-0: SKIP (0.000s)
[477.945063] [085/154] (553s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[478.038919] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[478.042517] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[478.130856] [086/154] (553s left) kms_vblank (query-forked-busy-hang)
[478.223683] Starting subtest: query-forked-busy-hang
[478.225521] Starting dynamic subtest: pipe-A-eDP-1
[480.101809] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.875s)
[480.118680] Starting dynamic subtest: pipe-D-eDP-1
[482.639295] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.536s)
[482.641466] Subtest query-forked-busy-hang: SUCCESS (4.416s)
[483.428951] [087/154] (547s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[483.490643] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[483.493053] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[483.542623] [088/154] (547s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[483.642780] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[483.646904] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[483.735215] [089/154] (547s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[483.792609] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[483.864657] [090/154] (547s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k)
[484.253926] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s)
[485.070962] [091/154] (546s left) kms_setmode (basic)
[485.133819] Starting subtest: basic
[485.452651] Starting dynamic subtest: pipe-A-eDP-1
[487.517660] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.061s)
[487.866025] Starting dynamic subtest: pipe-B-eDP-1
[489.949817] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.090s)
[490.269529] Subtest basic: SUCCESS (5.135s)
[491.091207] [092/154] (540s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[491.208237] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[523.063686] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (31.854s)
[523.920889] [093/154] (507s left) kms_frontbuffer_tracking (psrhdr-modesetfrombusy)
[524.032343] Starting subtest: psrhdr-modesetfrombusy
[524.036197] Subtest psrhdr-modesetfrombusy: SKIP (0.000s)
[524.122379] [094/154] (507s left) api_intel_allocator (fork-simple-stress-signal)
[524.187083] Starting subtest: fork-simple-stress-signal
[529.586472] Subtest fork-simple-stress-signal: SUCCESS (5.401s)
[529.676985] [095/154] (502s left) kms_chamelium_color (ctm-0-25)
[529.781463] Subtest ctm-0-25: SKIP (0.000s)
[529.833847] [096/154] (501s left) api_intel_bb (intel-bb-blit-y)
[529.892777] Starting subtest: intel-bb-blit-y
[533.270107] Subtest intel-bb-blit-y: SUCCESS (3.377s)
[533.359963] [097/154] (498s left) kms_pm_backlight (brightness-with-dpms)
[533.458997] Starting subtest: brightness-with-dpms
[533.511598] Starting dynamic subtest: eDP-1
[536.028090] Dynamic subtest eDP-1: SUCCESS (2.516s)
[536.030358] Subtest brightness-with-dpms: SUCCESS (2.568s)
[536.887926] [098/154] (494s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[537.289873] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[538.127693] [099/154] (493s left) gem_exec_reloc (basic-wc-cpu)
[538.180076] Subtest basic-wc-cpu: SKIP (0.000s)
[538.255747] [100/154] (493s left) gem_pread (exhaustion)
[538.312950] Subtest exhaustion: SKIP (0.000s)
[538.371131] [101/154] (493s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[538.468483] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[538.472746] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[538.533302] [102/154] (493s left) kms_plane (pixel-format-4-tiled-modifier)
[538.626427] Starting subtest: pixel-format-4-tiled-modifier
[538.652869] Starting dynamic subtest: pipe-A-plane-0
[539.052944] Dynamic subtest pipe-A-plane-0: SUCCESS (0.400s)
[539.064849] Starting dynamic subtest: pipe-A-plane-3
[539.374877] Dynamic subtest pipe-A-plane-3: SUCCESS (0.321s)
[539.388071] Starting dynamic subtest: pipe-A-plane-5
[539.391893] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[540.542452] Starting dynamic subtest: pipe-B-plane-0
[540.932266] Dynamic subtest pipe-B-plane-0: SUCCESS (0.400s)
[540.944528] Starting dynamic subtest: pipe-B-plane-3
[541.243064] Dynamic subtest pipe-B-plane-3: SUCCESS (0.310s)
[541.253732] Starting dynamic subtest: pipe-B-plane-5
[541.258393] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[541.557076] Subtest pixel-format-4-tiled-modifier: SUCCESS (2.931s)
[542.393898] [103/154] (489s left) kms_psr (pr-cursor-blt)
[542.488199] Starting subtest: pr-cursor-blt
[542.492729] Subtest pr-cursor-blt: SKIP (0.000s)
[542.540985] [104/154] (489s left) kms_pm_rpm (modeset-lpsp)
[544.465365] Starting subtest: modeset-lpsp
[545.950891] Subtest modeset-lpsp: SUCCESS (1.485s)
[546.020471] [105/154] (486s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[546.130655] Starting subtest: psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[546.134713] Subtest psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[546.193162] [106/154] (485s left) gem_ctx_param (invalid-ctx-set)
[546.247783] Starting subtest: invalid-ctx-set
[546.250195] Subtest invalid-ctx-set: SUCCESS (0.001s)
[546.334572] [107/154] (485s left) i915_drm_fdinfo (virtual-idle)
[546.380071] Starting subtest: virtual-idle
[549.437045] Subtest virtual-idle: SUCCESS (3.055s)
[549.495184] [108/154] (482s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[549.680790] Starting subtest: cursor-rapid-movement-64x64
[549.686024] Starting dynamic subtest: pipe-A-eDP-1
[550.220667] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.534s)
[550.248065] Starting dynamic subtest: pipe-D-eDP-1
[551.412266] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.171s)
[551.414582] Subtest cursor-rapid-movement-64x64: SUCCESS (1.729s)
[552.239959] [109/154] (480s left) kms_frontbuffer_tracking (fbchdr-2p-rte)
[552.328871] Starting subtest: fbchdr-2p-rte
[552.333319] Subtest fbchdr-2p-rte: SKIP (0.000s)
[552.411056] [110/154] (479s left) kms_busy (extended-modeset-hang-oldfb)
[552.511308] Starting subtest: extended-modeset-hang-oldfb
[552.513544] Starting dynamic subtest: pipe-A
[564.041577] Dynamic subtest pipe-A: SUCCESS (11.531s)
[564.054252] Starting dynamic subtest: pipe-D
[576.309635] Dynamic subtest pipe-D: SUCCESS (12.263s)
[576.311881] Subtest extended-modeset-hang-oldfb: SUCCESS (23.798s)
[577.173180] [111/154] (455s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[577.284963] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[578.287656] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.003s)
[578.413984] [112/154] (453s left) gem_mmap_offset (clear)
[578.469084] Starting subtest: clear
[578.471351] Starting dynamic subtest: smem0
[603.555239] Dynamic subtest smem0: SUCCESS (25.081s)
[603.557761] Subtest clear: SUCCESS (25.082s)
[603.685321] [113/154] (428s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[603.832151] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[603.834388] Starting dynamic subtest: pipe-A-eDP-1
[603.857716] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[603.870655] Starting dynamic subtest: pipe-B-eDP-1
[603.893072] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[603.903771] Starting dynamic subtest: pipe-C-eDP-1
[603.925568] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[603.936237] Starting dynamic subtest: pipe-D-eDP-1
[603.959393] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[603.963449] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[606.130244] [114/154] (426s left) dumb_buffer (create-clear)
[606.184180] Starting subtest: create-clear
[640.134608] Subtest create-clear: SUCCESS (33.946s)
[640.198482] [115/154] (392s left) gem_mmap_gtt (cpuset-big-copy-xy)
[640.252317] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[640.319878] [116/154] (392s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[640.424050] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-mmap-cpu
[640.428197] Subtest fbchdr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[640.496775] [117/154] (392s left) kms_addfb_basic (invalid-smem-bo-on-discrete)
[640.549245] Starting subtest: invalid-smem-bo-on-discrete
[640.553635] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s)
[640.677351] [118/154] (392s left) gem_exec_schedule (pi-common)
[640.871637] Starting subtest: pi-common
[640.874033] Starting dynamic subtest: rcs0
[640.903517] Dynamic subtest rcs0: SUCCESS (0.035s)
[640.923202] Starting dynamic subtest: bcs0
[640.945395] Dynamic subtest bcs0: SUCCESS (0.041s)
[640.959812] Starting dynamic subtest: vcs0
[640.979200] Dynamic subtest vcs0: SUCCESS (0.033s)
[640.992756] Starting dynamic subtest: vcs1
[641.010639] Dynamic subtest vcs1: SUCCESS (0.030s)
[641.026162] Starting dynamic subtest: vecs0
[641.039403] Dynamic subtest vecs0: SUCCESS (0.028s)
[641.055383] Starting dynamic subtest: ccs0
[641.067872] Dynamic subtest ccs0: SUCCESS (0.028s)
[641.070076] Subtest pi-common: SUCCESS (0.200s)
[641.285810] [119/154] (391s left) gem_exec_params (invalid-ring)
[641.349279] Starting subtest: invalid-ring
[641.351783] Subtest invalid-ring: SUCCESS (0.000s)
[641.456907] [120/154] (391s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-blt)
[641.550804] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-blt
[641.554823] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[641.627117] [121/154] (391s left) perf_pmu (event-wait)
[641.663874] Starting subtest: event-wait
[641.666349] Starting dynamic subtest: rcs0
[641.670592] Dynamic subtest rcs0: SKIP (0.000s)
[641.674649] Subtest event-wait: SKIP (0.001s)
[641.772223] [122/154] (391s left) gem_mmap_wc (write-cpu-read-wc)
[641.832529] Subtest write-cpu-read-wc: SKIP (0.000s)
[641.906730] [123/154] (391s left) gem_exec_fence (basic-await)
[642.079783] Starting subtest: basic-await
[642.082342] Starting dynamic subtest: rcs0
[642.159469] Dynamic subtest rcs0: SUCCESS (0.079s)
[642.175515] Starting dynamic subtest: bcs0
[642.233346] Dynamic subtest bcs0: SUCCESS (0.073s)
[642.245718] Starting dynamic subtest: vcs0
[642.308739] Dynamic subtest vcs0: SUCCESS (0.073s)
[642.322554] Starting dynamic subtest: vcs1
[642.380764] Dynamic subtest vcs1: SUCCESS (0.071s)
[642.400736] Starting dynamic subtest: vecs0
[642.453213] Dynamic subtest vecs0: SUCCESS (0.071s)
[642.466100] Starting dynamic subtest: ccs0
[642.525784] Dynamic subtest ccs0: SUCCESS (0.071s)
[642.528255] Subtest basic-await: SUCCESS (0.447s)
[644.344174] [124/154] (388s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-mmap-wc)
[644.455298] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-mmap-wc
[644.459225] Subtest psrhdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[644.545652] [125/154] (388s left) kms_prop_blob (blob-prop-lifetime)
[644.592935] Starting subtest: blob-prop-lifetime
[644.594917] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[644.689427] [126/154] (388s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[644.796123] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[644.800369] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[644.880479] [127/154] (388s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[644.980376] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[644.984604] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[645.060623] [128/154] (388s left) gem_flink_basic (basic)
[645.119489] Starting subtest: basic
[645.121410] Subtest basic: SUCCESS (0.000s)
[645.180909] [129/154] (388s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[645.278057] Starting subtest: plane-scaler-unity-scaling-with-rotation
[645.280389] Starting dynamic subtest: pipe-A
[645.505119] Dynamic subtest pipe-A: SUCCESS (0.228s)
[645.515968] Starting dynamic subtest: pipe-B
[646.824822] Dynamic subtest pipe-B: SUCCESS (1.318s)
[646.837227] Starting dynamic subtest: pipe-C
[648.158401] Dynamic subtest pipe-C: SUCCESS (1.332s)
[648.171241] Starting dynamic subtest: pipe-D
[649.491330] Dynamic subtest pipe-D: SUCCESS (1.332s)
[649.493511] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.216s)
[650.661817] [130/154] (382s left) gem_mmap_gtt (big-bo-tiledy)
[650.720516] Subtest big-bo-tiledY: SKIP (0.000s)
[650.786940] [131/154] (382s left) gem_ctx_engines (execute-allforone)
[650.856406] Starting subtest: execute-allforone
[650.868886] Subtest execute-allforone: SUCCESS (0.015s)
[652.309455] [132/154] (380s left) gem_exec_flush (basic-uc-ro-default)
[652.380923] Starting subtest: basic-uc-ro-default
[657.840500] Subtest basic-uc-ro-default: SUCCESS (5.461s)
[658.007363] [133/154] (375s left) i915_drm_fdinfo (context-close-stress)
[658.045347] Starting subtest: context-close-stress
[668.792204] Subtest context-close-stress: SUCCESS (10.746s)
[668.844664] [134/154] (364s left) gem_spin_batch (spin-all-new)
[669.051716] Starting subtest: spin-all-new
[669.075685] Subtest spin-all-new: SUCCESS (0.024s)
[670.284406] [135/154] (363s left) perf (gen12-group-concurrent-oa-buffer-read)
[670.384703] Starting subtest: gen12-group-concurrent-oa-buffer-read
[680.431609] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.046s)
[680.482069] [136/154] (352s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[680.571565] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[680.573814] Starting dynamic subtest: pipe-A-default-mode
[681.724776] Dynamic subtest pipe-A-default-mode: SKIP (1.151s)
[681.729207] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.152s)
[681.848714] [137/154] (351s left) kms_fb_coherency (memset-crc)
[681.951386] Starting subtest: memset-crc
[681.953541] Starting dynamic subtest: mmap-offset-wc
[682.360792] Dynamic subtest mmap-offset-wc: SUCCESS (0.411s)
[682.659508] Starting dynamic subtest: mmap-offset-uc
[688.765619] Dynamic subtest mmap-offset-uc: SUCCESS (6.116s)
[689.062061] Subtest memset-crc: SUCCESS (7.111s)
[689.856888] [138/154] (343s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs)
[689.959735] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs
[689.961903] Starting dynamic subtest: pipe-A-eDP-1
[689.985137] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[689.997653] Starting dynamic subtest: pipe-B-eDP-1
[690.019282] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[690.030593] Starting dynamic subtest: pipe-C-eDP-1
[690.052957] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[690.063722] Starting dynamic subtest: pipe-D-eDP-1
[690.085836] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[690.089972] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[692.223042] [139/154] (341s left) gem_exec_balancer (bonded-pair)
[692.277919] Starting subtest: bonded-pair
[692.282475] Subtest bonded-pair: SKIP (0.000s)
[692.563336] [140/154] (341s left) syncobj_timeline (multi-wait-for-submit-signaled)
[692.615573] Starting subtest: multi-wait-for-submit-signaled
[692.617973] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[692.685428] [141/154] (340s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[692.784797] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[692.789208] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[692.871245] [142/154] (340s left) gem_busy (extended)
[693.064443] Starting subtest: extended
[693.066847] Starting dynamic subtest: rcs0
[693.157874] Dynamic subtest rcs0: SUCCESS (0.096s)
[693.172415] Starting dynamic subtest: bcs0
[693.200046] Dynamic subtest bcs0: SUCCESS (0.040s)
[693.213989] Starting dynamic subtest: vcs0
[694.265435] Dynamic subtest vcs0: SUCCESS (1.062s)
[694.291924] Starting dynamic subtest: vcs1
[696.313656] Dynamic subtest vcs1: SUCCESS (2.045s)
[696.326275] Starting dynamic subtest: vecs0
[698.298226] Dynamic subtest vecs0: SUCCESS (1.982s)
[698.312662] Starting dynamic subtest: ccs0
[698.343877] Dynamic subtest ccs0: SUCCESS (0.045s)
[698.346999] Subtest extended: SUCCESS (5.284s)
[698.566457] [143/154] (335s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs)
[698.664877] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs
[698.667160] Starting dynamic subtest: pipe-A-eDP-1
[698.689710] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[698.703661] Starting dynamic subtest: pipe-B-eDP-1
[698.725463] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[698.736223] Starting dynamic subtest: pipe-C-eDP-1
[698.757662] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[698.768469] Starting dynamic subtest: pipe-D-eDP-1
[698.791173] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[698.795586] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[700.981886] [144/154] (332s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[701.080628] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[707.639556] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.564s)
[707.744380] [145/154] (326s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[707.805188] Starting subtest: invalid-bsd1-flag-on-vebox
[707.807485] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s)
[707.886914] [146/154] (326s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[707.985734] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[707.989725] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[708.068566] [147/154] (325s left) kms_vblank (ts-continuation-modeset-hang)
[708.176314] Starting subtest: ts-continuation-modeset-hang
[708.178112] Starting dynamic subtest: pipe-A-eDP-1
[735.095482] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.919s)
[735.113664] Starting dynamic subtest: pipe-D-eDP-1
[760.058888] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.959s)
[760.060745] Subtest ts-continuation-modeset-hang: SUCCESS (51.882s)
[760.858018] [148/154] (273s left) kms_addfb_basic (invalid-get-prop)
[760.916435] Starting subtest: invalid-get-prop
[760.918479] Subtest invalid-get-prop: SUCCESS (0.000s)
[761.037494] [149/154] (272s left) kms_big_fb (linear-8bpp-rotate-270)
[761.141905] Starting subtest: linear-8bpp-rotate-270
[761.162717] Subtest linear-8bpp-rotate-270: SKIP (0.020s)
[761.256762] [150/154] (272s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-blt)
[761.349637] Starting subtest: fbchdr-rgb565-draw-blt
[761.354100] Subtest fbchdr-rgb565-draw-blt: SKIP (0.000s)
[761.419666] [151/154] (272s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping)
[761.517282] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping
[761.521267] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[761.569352] [152/154] (272s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[761.631813] Starting subtest: yf-tiled-to-vebox-yf-tiled
[761.636105] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[761.796910] [153/154] (272s left) vgem_basic (dmabuf-fence-before)
[761.833159] Starting subtest: dmabuf-fence-before
[761.835417] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[761.874212] [154/154] (272s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[761.984087] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[761.988237] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[762.061132] Closing watchdogs
results: parsing output: 0/ for test: kms_rmfb
results: parsing output: 1/ for test: gem_exec_fence
results: parsing output: 2/ for test: gem_exec_schedule
results: parsing output: 3/ for test: i915_pm_rpm
results: parsing output: 4/ for test: gem_lmem_swapping
results: parsing output: 5/ for test: gem_ctx_persistence
results: parsing output: 6/ for test: kms_properties
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_psr2_sf
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: gem_exec_whisper
results: parsing output: 11/ for test: prime_mmap
results: parsing output: 12/ for test: prime_vgem
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_psr
results: parsing output: 18/ for test: kms_cursor_crc
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: syncobj_timeline
results: parsing output: 21/ for test: gem_userptr_blits
results: parsing output: 22/ for test: gem_exec_params
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: kms_cursor_legacy
results: parsing output: 25/ for test: gem_exec_params
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: syncobj_wait
results: parsing output: 28/ for test: kms_getfb
results: parsing output: 29/ for test: kms_cursor_legacy
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_cursor_legacy
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: perf_pmu
results: parsing output: 34/ for test: kms_psr
results: parsing output: 35/ for test: kms_rotation_crc
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_flip
results: parsing output: 38/ for test: gem_flink_basic
results: parsing output: 39/ for test: gen9_exec_parse
results: parsing output: 40/ for test: gen7_exec_parse
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_flip
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: gem_ctx_persistence
results: parsing output: 46/ for test: kms_properties
results: parsing output: 47/ for test: kms_color_pipeline
results: parsing output: 48/ for test: syncobj_timeline
results: parsing output: 49/ for test: vgem_basic
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: kms_joiner
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: gem_pxp
results: parsing output: 55/ for test: kms_lease
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_fenced_exec_thrash
results: parsing output: 58/ for test: gem_exec_create
results: parsing output: 59/ for test: vgem_basic
results: parsing output: 60/ for test: kms_big_fb
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_force_connector_basic
results: parsing output: 64/ for test: syncobj_wait
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_flip
results: parsing output: 67/ for test: kms_psr2_su
results: parsing output: 68/ for test: syncobj_timeline
results: parsing output: 69/ for test: gem_reg_read
results: parsing output: 70/ for test: gem_ctx_shared
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: i915_selftest
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: kms_atomic_transition
results: parsing output: 77/ for test: gem_eio
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_plane_cursor
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_big_fb
results: parsing output: 83/ for test: kms_content_protection
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_vblank
results: parsing output: 86/ for test: syncobj_wait
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_pipe_b_c_ivb
results: parsing output: 89/ for test: kms_chamelium_edid
results: parsing output: 90/ for test: kms_setmode
results: parsing output: 91/ for test: kms_cursor_legacy
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: api_intel_allocator
results: parsing output: 94/ for test: kms_chamelium_color
results: parsing output: 95/ for test: api_intel_bb
results: parsing output: 96/ for test: kms_pm_backlight
results: parsing output: 97/ for test: kms_chamelium_hpd
results: parsing output: 98/ for test: gem_exec_reloc
results: parsing output: 99/ for test: gem_pread
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_plane
results: parsing output: 102/ for test: kms_psr
results: parsing output: 103/ for test: kms_pm_rpm
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: gem_ctx_param
results: parsing output: 106/ for test: i915_drm_fdinfo
results: parsing output: 107/ for test: kms_cursor_crc
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_busy
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: gem_mmap_offset
results: parsing output: 112/ for test: kms_ccs
results: parsing output: 113/ for test: dumb_buffer
results: parsing output: 114/ for test: gem_mmap_gtt
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_addfb_basic
results: parsing output: 117/ for test: gem_exec_schedule
results: parsing output: 118/ for test: gem_exec_params
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: perf_pmu
results: parsing output: 121/ for test: gem_mmap_wc
results: parsing output: 122/ for test: gem_exec_fence
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_prop_blob
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: gem_flink_basic
results: parsing output: 128/ for test: kms_plane_scaling
results: parsing output: 129/ for test: gem_mmap_gtt
results: parsing output: 130/ for test: gem_ctx_engines
results: parsing output: 131/ for test: gem_exec_flush
results: parsing output: 132/ for test: i915_drm_fdinfo
results: parsing output: 133/ for test: gem_spin_batch
results: parsing output: 134/ for test: perf
results: parsing output: 135/ for test: kms_flip_scaled_crc
results: parsing output: 136/ for test: kms_fb_coherency
results: parsing output: 137/ for test: kms_ccs
results: parsing output: 138/ for test: gem_exec_balancer
results: parsing output: 139/ for test: syncobj_timeline
results: parsing output: 140/ for test: kms_frontbuffer_tracking
results: parsing output: 141/ for test: gem_busy
results: parsing output: 142/ for test: kms_ccs
results: parsing output: 143/ for test: kms_frontbuffer_tracking
results: parsing output: 144/ for test: gem_exec_params
results: parsing output: 145/ for test: kms_frontbuffer_tracking
results: parsing output: 146/ for test: kms_vblank
results: parsing output: 147/ for test: kms_addfb_basic
results: parsing output: 148/ for test: kms_big_fb
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: kms_plane
results: parsing output: 151/ for test: gem_render_copy
results: parsing output: 152/ for test: vgem_basic
results: parsing output: 153/ for test: kms_frontbuffer_tracking
Done.