[90.052942] Initializing watchdogs
[90.053158]   /dev/watchdog0
[90.093478] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[90.108659] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[90.115780] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[90.124061] [001/133] (960s left) kms_psr (pr-primary-render)
[90.344849] Subtest pr-primary-render: SKIP (0.000s)
[90.445185] [002/133] (960s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs)
[90.641805] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs
[90.645170] Starting dynamic subtest: pipe-A-HDMI-A-1
[90.690240] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[90.724513] Starting dynamic subtest: pipe-A-HDMI-A-2
[90.773403] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s)
[90.806263] Starting dynamic subtest: pipe-B-HDMI-A-1
[90.841995] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[90.861413] Starting dynamic subtest: pipe-B-HDMI-A-2
[90.893084] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s)
[90.910857] Starting dynamic subtest: pipe-C-HDMI-A-1
[90.940857] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[90.958205] Starting dynamic subtest: pipe-C-HDMI-A-2
[90.991880] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s)
[90.998268] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.022s)
[91.730369] [003/133] (959s left) kms_pm_dc (dc6-dpms)
[92.927328] Starting subtest: dc6-dpms
[92.938270] Subtest dc6-dpms: SKIP (0.000s)
[93.068492] [004/133] (957s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[93.269210] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[93.273436] Starting dynamic subtest: pipe-A
[94.350156] Dynamic subtest pipe-A: SUCCESS (1.086s)
[94.374044] Starting dynamic subtest: pipe-B
[95.462206] Dynamic subtest pipe-B: SUCCESS (1.109s)
[95.481490] Starting dynamic subtest: pipe-C
[95.924300] Dynamic subtest pipe-C: SUCCESS (0.460s)
[95.928713] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (2.658s)
[96.471347] [005/133] (954s left) drm_read (short-buffer-block)
[96.973400] Starting subtest: short-buffer-block
[96.977095] Subtest short-buffer-block: SUCCESS (0.001s)
[97.257957] [006/133] (953s left) kms_panel_fitting (legacy)
[97.439103] Starting subtest: legacy
[97.445953] Subtest legacy: SKIP (0.000s)
[97.573048] [007/133] (953s left) i915_pm_rpm (gem-execbuf-stress)
[99.503037] Starting subtest: gem-execbuf-stress
[99.506943] Starting dynamic subtest: smem0
[102.184876] Dynamic subtest smem0: SUCCESS (2.683s)
[102.209077] Starting dynamic subtest: extra-wait-smem0
[154.832648] Dynamic subtest extra-wait-smem0: SUCCESS (52.638s)
[154.839102] Subtest gem-execbuf-stress: SUCCESS (55.325s)
[155.228762] [008/133] (896s left) gem_exec_fence (submit)
[155.493391] Starting subtest: submit
[155.496929] Starting dynamic subtest: rcs0
[155.524061] Dynamic subtest rcs0: SUCCESS (0.030s)
[155.563495] Starting dynamic subtest: bcs0
[155.567957] Dynamic subtest bcs0: SUCCESS (0.023s)
[155.598219] Starting dynamic subtest: vcs0
[155.602483] Dynamic subtest vcs0: SUCCESS (0.020s)
[155.622211] Starting dynamic subtest: vecs0
[155.626376] Dynamic subtest vecs0: SUCCESS (0.021s)
[155.630545] Subtest submit: SUCCESS (0.098s)
[156.364115] [FACT gem_exec_fence (submit)] new: kernel.kmod_is_loaded.vgem: true
[156.370681] [009/133] (895s left) i915_drm_fdinfo (memory-info-shared)
[156.487109] Starting subtest: memory-info-shared
[156.492140] Starting dynamic subtest: smem0
[156.521799] Dynamic subtest smem0: SUCCESS (0.038s)
[156.525741] Subtest memory-info-shared: SUCCESS (0.038s)
[156.699051] [010/133] (894s left) syncobj_wait (invalid-wait-bad-flags)
[156.806764] Starting subtest: invalid-wait-bad-flags
[156.810059] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[156.952926] [011/133] (894s left) gem_mmap_gtt (big-copy)
[157.060286] Starting subtest: big-copy
[165.136232] Subtest big-copy: SUCCESS (8.075s)
[165.310910] [012/133] (886s left) api_intel_bb (reset-flags)
[165.551096] Starting subtest: reset-flags
[165.565355] Subtest reset-flags: SUCCESS (0.019s)
[165.735220] [013/133] (886s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[165.870177] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[165.873850] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.002s)
[166.019140] [014/133] (885s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[166.185992] Starting subtest: tiled-to-tiled
[166.363580] Subtest tiled-to-tiled: SUCCESS (0.173s)
[166.545157] [015/133] (885s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[166.707906] Starting subtest: multi-wait-all-for-submit-available-submitted
[166.720084] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.007s)
[166.971759] [016/133] (885s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[167.270502] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[167.283332] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[167.578597] [017/133] (884s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[167.863112] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[167.881116] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.004s)
[168.117623] [018/133] (884s left) gem_ctx_exec (basic)
[168.272258] Starting subtest: basic
[168.282341] Subtest basic: SUCCESS (0.007s)
[168.432602] [019/133] (884s left) syncobj_basic (bad-destroy)
[168.543128] Starting subtest: bad-destroy
[168.546220] Subtest bad-destroy: SUCCESS (0.000s)
[168.711971] [020/133] (884s left) gem_spin_batch (spin-all)
[168.837467] Starting subtest: spin-all
[168.863218] Subtest spin-all: SUCCESS (0.025s)
[169.153312] [021/133] (883s left) gem_userptr_blits (unsync-unmap-cycles)
[169.280132] Subtest unsync-unmap-cycles: SKIP (0.000s)
[169.469108] [022/133] (883s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[169.661066] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[169.780026] [023/133] (883s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[169.987526] Starting subtest: fbcpsr-modesetfrombusy
[169.993864] Subtest fbcpsr-modesetfrombusy: SKIP (0.000s)
[170.134754] [024/133] (883s left) gem_exec_whisper (basic-fds)
[170.285062] Starting subtest: basic-fds
[185.392542] Subtest basic-fds: SUCCESS (15.112s)
[185.652435] [025/133] (867s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[185.832557] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[185.840995] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[185.985634] [026/133] (867s left) syncobj_wait (multi-wait-all-signaled)
[186.099130] Starting subtest: multi-wait-all-signaled
[186.103646] Subtest multi-wait-all-signaled: SUCCESS (0.002s)
[186.252746] [027/133] (867s left) gem_exec_flush (basic-wb-prw-default)
[186.377141] Starting subtest: basic-wb-prw-default
[191.791027] Subtest basic-wb-prw-default: SUCCESS (5.415s)
[192.050121] [028/133] (861s left) kms_getfb (getfb2-handle-zero)
[192.239243] Starting subtest: getfb2-handle-zero
[192.242481] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[192.387585] [029/133] (861s left) kms_plane (pixel-format-x-tiled-modifier)
[192.586448] Starting subtest: pixel-format-x-tiled-modifier
[192.796948] Starting dynamic subtest: pipe-A-plane-0
[193.513239] Dynamic subtest pipe-A-plane-0: SUCCESS (0.717s)
[193.536846] Starting dynamic subtest: pipe-A-plane-1
[194.179486] Dynamic subtest pipe-A-plane-1: SUCCESS (0.665s)
[194.202419] Starting dynamic subtest: pipe-A-plane-2
[194.664161] Dynamic subtest pipe-A-plane-2: SUCCESS (0.482s)
[194.687302] Starting dynamic subtest: pipe-A-plane-3
[195.162975] Dynamic subtest pipe-A-plane-3: SUCCESS (0.499s)
[195.185578] Starting dynamic subtest: pipe-A-plane-4
[195.195047] Dynamic subtest pipe-A-plane-4: SKIP (0.000s)
[195.545233] Starting dynamic subtest: pipe-B-plane-0
[196.177614] Dynamic subtest pipe-B-plane-0: SUCCESS (0.650s)
[196.201459] Starting dynamic subtest: pipe-B-plane-1
[196.827567] Dynamic subtest pipe-B-plane-1: SUCCESS (0.650s)
[196.850597] Starting dynamic subtest: pipe-B-plane-2
[197.308689] Dynamic subtest pipe-B-plane-2: SUCCESS (0.483s)
[197.331274] Starting dynamic subtest: pipe-B-plane-3
[197.808809] Dynamic subtest pipe-B-plane-3: SUCCESS (0.498s)
[197.843384] Starting dynamic subtest: pipe-B-plane-4
[197.854751] Dynamic subtest pipe-B-plane-4: SKIP (0.000s)
[198.007800] Subtest pixel-format-x-tiled-modifier: SUCCESS (5.426s)
[198.316584] [030/133] (855s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping)
[198.501297] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping
[198.507501] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[198.649813] [031/133] (855s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[198.758087] Starting subtest: single-wait-all-for-submit-available-submitted
[198.764059] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.001s)
[198.894588] [032/133] (855s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[199.002917] Starting subtest: multi-wait-for-submit-unsubmitted
[199.109931] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.105s)
[199.263361] [033/133] (854s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[199.467490] Starting subtest: fbcpsr-stridechange
[199.475112] Subtest fbcpsr-stridechange: SKIP (0.000s)
[199.631478] [034/133] (854s left) kms_plane_scaling (planes-upscale-factor-0-25)
[199.822495] Starting subtest: planes-upscale-factor-0-25
[199.827243] Starting dynamic subtest: pipe-A
[200.146175] Dynamic subtest pipe-A: SUCCESS (0.328s)
[200.191102] Starting dynamic subtest: pipe-B
[200.559462] Dynamic subtest pipe-B: SUCCESS (0.412s)
[200.589509] Starting dynamic subtest: pipe-C
[200.643538] Dynamic subtest pipe-C: SUCCESS (0.083s)
[200.648243] Subtest planes-upscale-factor-0-25: SUCCESS (0.827s)
[201.168956] [035/133] (853s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs)
[201.350101] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs
[201.353113] Starting dynamic subtest: pipe-A-HDMI-A-1
[201.388572] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[201.432066] Starting dynamic subtest: pipe-A-HDMI-A-2
[201.468349] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s)
[201.493597] Starting dynamic subtest: pipe-B-HDMI-A-1
[201.527356] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[201.551322] Starting dynamic subtest: pipe-B-HDMI-A-2
[201.583099] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s)
[201.605353] Starting dynamic subtest: pipe-C-HDMI-A-1
[201.636971] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[201.661977] Starting dynamic subtest: pipe-C-HDMI-A-2
[201.692954] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s)
[201.699329] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.019s)
[202.842793] [036/133] (852s left) gem_userptr_blits (huge-split)
[203.499520] Starting subtest: huge-split
[203.618622] Subtest huge-split: SUCCESS (0.010s)
[203.712496] [037/133] (851s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[203.897828] Starting subtest: basic-flip-after-cursor-varying-size
[205.272324] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.371s)
[205.593425] [038/133] (849s left) i915_query (query-topology-known-pci-ids)
[205.704498] Starting subtest: query-topology-known-pci-ids
[205.713077] Subtest query-topology-known-pci-ids: SKIP (0.000s)
[205.839309] [039/133] (849s left) drm_read (short-buffer-nonblock)
[206.265736] Starting subtest: short-buffer-nonblock
[206.268872] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[206.548207] [040/133] (848s left) gem_mmap_offset (partial-mmap)
[206.662239] Starting subtest: partial-mmap
[206.666524] Starting dynamic subtest: smem0
[206.670802] Dynamic subtest smem0: SUCCESS (0.008s)
[206.674321] Subtest partial-mmap: SUCCESS (0.010s)
[206.825999] [041/133] (848s left) kms_getfb (getfb-handle-closed)
[207.003231] Starting subtest: getfb-handle-closed
[207.006658] Subtest getfb-handle-closed: SUCCESS (0.000s)
[207.161570] [042/133] (848s left) kms_flip (plain-flip-ts-check-interruptible)
[207.360252] Starting subtest: plain-flip-ts-check-interruptible
[207.365253] Starting dynamic subtest: A-HDMI-A1
[213.268437] Dynamic subtest A-HDMI-A1: SUCCESS (5.904s)
[213.295402] Starting dynamic subtest: B-HDMI-A1
[218.939259] Dynamic subtest B-HDMI-A1: SUCCESS (5.665s)
[218.962626] Starting dynamic subtest: C-HDMI-A1
[224.599399] Dynamic subtest C-HDMI-A1: SUCCESS (5.657s)
[224.624946] Starting dynamic subtest: A-HDMI-A2
[230.286098] Dynamic subtest A-HDMI-A2: SUCCESS (5.681s)
[230.310057] Starting dynamic subtest: B-HDMI-A2
[235.974297] Dynamic subtest B-HDMI-A2: SUCCESS (5.685s)
[235.997834] Starting dynamic subtest: C-HDMI-A2
[241.628069] Dynamic subtest C-HDMI-A2: SUCCESS (5.651s)
[241.634146] Subtest plain-flip-ts-check-interruptible: SUCCESS (34.267s)
[242.158741] [043/133] (813s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[242.363091] Starting subtest: y-tiled-64bpp-rotate-180
[249.187745] Subtest y-tiled-64bpp-rotate-180: SUCCESS (6.826s)
[249.722591] [044/133] (806s left) kms_content_protection (uevent-hdcp14)
[249.928772] Starting subtest: uevent-hdcp14
[249.964290] Subtest uevent-hdcp14: SKIP (0.035s)
[250.137797] [045/133] (805s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[250.351982] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[250.356156] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[252.096235] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (1.740s)
[252.124152] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[253.741423] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (1.602s)
[253.781477] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[255.382264] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (1.672s)
[255.387328] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SUCCESS (5.035s)
[256.005659] [046/133] (799s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[256.225534] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[256.232273] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[256.376578] [047/133] (799s left) gem_create (hog-create)
[256.500310] Starting subtest: hog-create
[256.504231] Starting dynamic subtest: smem0
[288.755647] Dynamic subtest smem0: SUCCESS (32.255s)
[288.758775] Subtest hog-create: SUCCESS (32.259s)
[289.029682] [048/133] (767s left) gem_eio (unwedge-stress)
[289.187900] Starting subtest: unwedge-stress
[289.194342] Starting dynamic subtest: render
[290.968111] Dynamic subtest render: SUCCESS (1.778s)
[291.003259] Starting dynamic subtest: bsd
[292.849530] Dynamic subtest bsd: SUCCESS (1.877s)
[292.877023] Starting dynamic subtest: blt
[295.623284] Dynamic subtest blt: SUCCESS (2.770s)
[295.649256] Starting dynamic subtest: vebox
[297.520934] Dynamic subtest vebox: SUCCESS (1.896s)
[297.524243] Subtest unwedge-stress: SUCCESS (8.337s)
[297.759901] [049/133] (758s left) gem_exec_reloc (basic-softpin)
[297.888398] Starting subtest: basic-softpin
[297.891470] Subtest basic-softpin: SUCCESS (0.006s)
[298.130226] [050/133] (758s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[298.350511] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[301.029069] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SUCCESS (2.683s)
[301.261730] [051/133] (755s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[301.475070] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[301.481562] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[301.631215] [052/133] (754s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[301.741332] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[301.844988] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.102s)
[301.995827] [053/133] (754s left) kms_joiner (invalid-modeset-force-big-joiner)
[302.187437] Starting subtest: invalid-modeset-force-big-joiner
[302.198126] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[302.330449] [054/133] (754s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[302.522063] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[302.525247] Starting dynamic subtest: pipe-A-HDMI-A-1
[302.562147] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.003s)
[302.611447] Starting dynamic subtest: pipe-A-HDMI-A-2
[302.670049] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.003s)
[302.705095] Starting dynamic subtest: pipe-B-HDMI-A-1
[302.733111] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.003s)
[302.756119] Starting dynamic subtest: pipe-B-HDMI-A-2
[302.785091] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.004s)
[302.808217] Starting dynamic subtest: pipe-C-HDMI-A-1
[302.835666] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.003s)
[302.858561] Starting dynamic subtest: pipe-C-HDMI-A-2
[302.888095] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.005s)
[302.893788] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.049s)
[303.594624] [055/133] (753s left) gem_exec_schedule (semaphore-user)
[303.740173] Starting subtest: semaphore-user
[303.755868] Subtest semaphore-user: SUCCESS (0.018s)
[304.158589] [056/133] (752s left) gem_exec_suspend (basic)
[304.289327] Starting subtest: basic
[304.293057] Starting dynamic subtest: smem
[305.445128] Dynamic subtest smem: SUCCESS (1.149s)
[305.448813] Subtest basic: SUCCESS (1.153s)
[305.768273] [057/133] (751s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[305.927650] Starting subtest: map-fixed-invalidate-overlap
[305.932092] Starting dynamic subtest: gtt
[306.199706] Dynamic subtest gtt: SUCCESS (0.270s)
[306.226739] Starting dynamic subtest: wb
[306.368240] Dynamic subtest wb: SUCCESS (0.165s)
[306.394017] Starting dynamic subtest: wc
[306.532238] Dynamic subtest wc: SUCCESS (0.162s)
[306.566321] Starting dynamic subtest: uc
[306.706238] Dynamic subtest uc: SUCCESS (0.168s)
[306.710194] Subtest map-fixed-invalidate-overlap: SUCCESS (0.779s)
[306.906932] [058/133] (750s left) kms_busy (extended-pageflip-hang-newfb)
[307.115595] Starting subtest: extended-pageflip-hang-newfb
[307.119625] Starting dynamic subtest: pipe-A
[311.936065] Dynamic subtest pipe-A: SUCCESS (4.824s)
[311.971260] Starting dynamic subtest: pipe-C
[315.877368] Dynamic subtest pipe-C: SUCCESS (3.923s)
[315.880867] Subtest extended-pageflip-hang-newfb: SUCCESS (8.765s)
[316.263110] [059/133] (741s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[316.477561] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[316.484138] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[316.628221] [060/133] (740s left) i915_query (query-regions-sanity-check)
[316.741187] Starting subtest: query-regions-sanity-check
[316.763734] Subtest query-regions-sanity-check: SUCCESS (0.029s)
[316.941717] [061/133] (740s left) gem_exec_schedule (pi-shared-iova)
[317.199171] Starting subtest: pi-shared-iova
[317.203112] Starting dynamic subtest: rcs0
[317.259224] Dynamic subtest rcs0: SUCCESS (0.053s)
[317.293228] Starting dynamic subtest: bcs0
[317.343679] Dynamic subtest bcs0: SUCCESS (0.071s)
[317.379874] Starting dynamic subtest: vcs0
[317.392657] Dynamic subtest vcs0: SUCCESS (0.051s)
[317.428461] Starting dynamic subtest: vecs0
[317.448070] Dynamic subtest vecs0: SUCCESS (0.049s)
[317.451734] Subtest pi-shared-iova: SUCCESS (0.247s)
[317.726795] [062/133] (739s left) gem_exec_balancer (smoke)
[317.859533] Starting subtest: smoke
[322.238179] Subtest smoke: SUCCESS (4.380s)
[322.526627] [063/133] (735s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[322.721120] Starting subtest: cursor-tearing-framebuffer-change
[322.723888] Starting dynamic subtest: pipe-A-HDMI-A-1
[323.717189] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.869s)
[323.783051] Starting dynamic subtest: pipe-C-HDMI-A-1
[324.235045] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.535s)
[324.299451] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.415s)
[324.887977] [064/133] (733s left) gem_exec_reloc (basic-wc-read-noreloc)
[325.077784] Starting subtest: basic-wc-read-noreloc
[325.088133] Subtest basic-wc-read-noreloc: SUCCESS (0.009s)
[325.312403] [065/133] (733s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[325.891160] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[326.211374] [066/133] (732s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[326.411525] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[326.535219] [067/133] (732s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[326.755802] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[326.764449] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[326.909297] [068/133] (731s left) kms_psr (fbc-psr-sprite-plane-onoff)
[327.095327] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.000s)
[327.219242] [069/133] (731s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[327.422766] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[327.433780] Starting dynamic subtest: A-HDMI-A1
[328.917178] Dynamic subtest A-HDMI-A1: SUCCESS (1.482s)
[328.942695] Starting dynamic subtest: B-HDMI-A1
[329.854282] Dynamic subtest B-HDMI-A1: SUCCESS (0.933s)
[329.900032] Starting dynamic subtest: C-HDMI-A1
[330.824140] Dynamic subtest C-HDMI-A1: SUCCESS (0.967s)
[330.855949] Starting dynamic subtest: A-HDMI-A2
[331.839209] Dynamic subtest A-HDMI-A2: SUCCESS (1.007s)
[331.863305] Starting dynamic subtest: B-HDMI-A2
[332.783332] Dynamic subtest B-HDMI-A2: SUCCESS (0.940s)
[332.816938] Starting dynamic subtest: C-HDMI-A2
[333.776058] Dynamic subtest C-HDMI-A2: SUCCESS (0.986s)
[333.782142] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (6.353s)
[334.158670] [070/133] (724s left) kms_chamelium_hpd (common-hpd-after-suspend)
[334.792095] Subtest common-hpd-after-suspend: SKIP (0.000s)
[335.078319] [071/133] (723s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[335.287137] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[335.292058] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[346.369665] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (11.081s)
[346.399657] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[357.406176] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (11.029s)
[357.449305] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[368.438234] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (11.025s)
[368.441546] Subtest 2x-flip-vs-absolute-wf_vblank: SUCCESS (33.158s)
[369.140381] [072/133] (689s left) kms_vblank (wait-idle-hang)
[369.333220] Starting subtest: wait-idle-hang
[369.337085] Starting dynamic subtest: pipe-A-HDMI-A-1
[376.830199] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (7.498s)
[376.890659] Starting dynamic subtest: pipe-A-HDMI-A-2
[383.883085] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (7.039s)
[383.939177] Starting dynamic subtest: pipe-C-HDMI-A-1
[390.840967] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (6.950s)
[390.882735] Starting dynamic subtest: pipe-C-HDMI-A-2
[397.818096] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (6.971s)
[397.822288] Subtest wait-idle-hang: SUCCESS (28.492s)
[398.181179] [073/133] (661s left) kms_dp_link_training (uhbr-sst)
[398.377434] Starting subtest: uhbr-sst
[398.384621] Subtest uhbr-sst: SKIP (0.000s)
[398.542647] [074/133] (660s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[398.725311] Starting subtest: flip-vs-cursor-legacy
[416.992796] Subtest flip-vs-cursor-legacy: SUCCESS (18.268s)
[417.309157] [075/133] (642s left) gem_ctx_persistence (engines-hang)
[417.441041] Starting subtest: engines-hang
[417.448066] Starting dynamic subtest: rcs0
[417.472342] Dynamic subtest rcs0: SUCCESS (0.036s)
[417.512267] Starting dynamic subtest: bcs0
[417.519656] Dynamic subtest bcs0: SKIP (0.005s)
[417.544974] Starting dynamic subtest: vcs0
[417.549146] Dynamic subtest vcs0: SUCCESS (0.026s)
[417.576380] Starting dynamic subtest: vecs0
[417.580280] Dynamic subtest vecs0: SUCCESS (0.034s)
[417.583960] Subtest engines-hang: SUCCESS (0.116s)
[417.702816] [076/133] (641s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow)
[417.919646] Starting subtest: yf-tiled-addfb-size-offset-overflow
[417.923964] Subtest yf-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[418.074795] [077/133] (641s left) api_intel_allocator (reopen-fork)
[418.189435] Starting subtest: reopen-fork
[421.578181] Subtest reopen-fork: SUCCESS (3.388s)
[421.738296] [078/133] (638s left) kms_rmfb (rmfb-ioctl)
[421.931445] Starting subtest: rmfb-ioctl
[421.939300] Starting dynamic subtest: pipe-A-HDMI-A-1
[422.235740] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.313s)
[422.273134] Starting dynamic subtest: pipe-B-HDMI-A-2
[422.666400] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.425s)
[422.710320] Starting dynamic subtest: pipe-C-HDMI-A-1
[423.083958] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.409s)
[423.088746] Subtest rmfb-ioctl: SUCCESS (1.168s)
[423.617444] [079/133] (636s left) gem_ctx_persistence (smoketest)
[423.740416] Starting subtest: smoketest
[461.853584] Subtest smoketest: SUCCESS (38.110s)
[462.020561] [080/133] (597s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[462.145853] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[462.149464] Starting dynamic subtest: smem
[462.383085] Dynamic subtest smem: SUCCESS (0.233s)
[462.386734] Subtest y-tiled-ccs-to-y-tiled-ccs: SUCCESS (0.236s)
[462.654572] [081/133] (597s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[462.870038] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[465.433067] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (2.567s)
[465.738328] [082/133] (594s left) gem_exec_balancer (fairslice)
[465.866460] Starting subtest: fairslice
[465.873934] Subtest fairslice: SKIP (0.000s)
[466.152726] [083/133] (594s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[466.345093] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[466.466526] [084/133] (593s left) gem_eio (in-flight-contexts-1us)
[466.605141] Starting subtest: in-flight-contexts-1us
[477.991333] Subtest in-flight-contexts-1us: SUCCESS (11.393s)
[478.252710] [085/133] (582s left) perf_pmu (gt-awake)
[478.377038] Starting subtest: gt-awake
[480.943376] Subtest gt-awake: SUCCESS (2.570s)
[481.105805] [086/133] (579s left) gem_mmap_gtt (fault-concurrent-x)
[481.212946] Starting subtest: fault-concurrent-X
[487.201067] Subtest fault-concurrent-X: SUCCESS (5.984s)
[487.399623] [087/133] (573s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[487.602263] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[490.097829] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (2.499s)
[490.415136] [088/133] (570s left) gem_exec_whisper (basic-queues-forked)
[490.548441] Starting subtest: basic-queues-forked
[496.115972] Subtest basic-queues-forked: SUCCESS (5.562s)
[496.416729] [089/133] (564s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[496.634907] Starting subtest: 4-tiled-64bpp-rotate-180
[496.643176] Subtest 4-tiled-64bpp-rotate-180: SKIP (0.000s)
[496.790553] [090/133] (564s left) prime_vgem (sync)
[496.930097] Starting subtest: sync
[496.936197] Starting dynamic subtest: rcs0
[496.959102] Dynamic subtest rcs0: SUCCESS (0.025s)
[497.008600] Starting dynamic subtest: vcs0
[497.012062] Dynamic subtest vcs0: SUCCESS (0.018s)
[497.038446] Starting dynamic subtest: vecs0
[497.041929] Dynamic subtest vecs0: SUCCESS (0.012s)
[497.046153] Subtest sync: SUCCESS (0.066s)
[497.153298] [091/133] (563s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[499.808913] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted
[499.817145] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SKIP (0.000s)
[499.955491] [092/133] (561s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[500.167302] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[500.173945] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[500.322708] [093/133] (561s left) kms_lease (cursor-implicit-plane)
[500.510072] Starting subtest: cursor-implicit-plane
[500.513180] Starting dynamic subtest: pipe-A-HDMI-A-1
[501.188206] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.681s)
[501.229055] Starting dynamic subtest: pipe-A-HDMI-A-2
[501.637942] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.437s)
[501.672128] Starting dynamic subtest: pipe-B-HDMI-A-1
[502.085176] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.437s)
[502.125337] Starting dynamic subtest: pipe-B-HDMI-A-2
[502.553170] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.468s)
[502.607475] Starting dynamic subtest: pipe-C-HDMI-A-1
[502.978731] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.409s)
[503.010718] Starting dynamic subtest: pipe-C-HDMI-A-2
[503.392331] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.404s)
[503.398659] Subtest cursor-implicit-plane: SUCCESS (2.894s)
[503.720520] [094/133] (557s left) syncobj_timeline (multi-wait-submitted-signaled)
[503.845436] Starting subtest: multi-wait-submitted-signaled
[503.850098] Subtest multi-wait-submitted-signaled: SUCCESS (0.003s)
[504.002294] [095/133] (557s left) kms_psr (psr2-primary-page-flip)
[504.186747] Subtest psr2-primary-page-flip: SKIP (0.000s)
[504.312524] [096/133] (557s left) kms_cursor_crc (cursor-size-hints)
[504.510485] Starting subtest: cursor-size-hints
[504.513618] Starting dynamic subtest: pipe-A-HDMI-A-1
[505.431194] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.926s)
[505.476816] Starting dynamic subtest: pipe-C-HDMI-A-1
[506.059387] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.616s)
[506.062393] Subtest cursor-size-hints: SUCCESS (1.554s)
[506.409549] [097/133] (555s left) kms_plane_alpha_blend (coverage-7efc)
[506.616040] Starting subtest: coverage-7efc
[506.824436] Starting dynamic subtest: pipe-A-HDMI-A-1
[507.823277] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.993s)
[507.926534] Starting dynamic subtest: pipe-C-HDMI-A-1
[508.984129] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.088s)
[508.989064] Subtest coverage-7efc: SUCCESS (2.379s)
[509.314444] [098/133] (552s left) gem_exec_reloc (basic-active)
[509.459060] Starting subtest: basic-active
[509.463020] Starting dynamic subtest: all-engines
[509.856855] Dynamic subtest all-engines: SUCCESS (0.398s)
[509.907064] Starting dynamic subtest: rcs0
[510.091089] Dynamic subtest rcs0: SUCCESS (0.233s)
[510.140430] Starting dynamic subtest: bcs0
[510.457256] Dynamic subtest bcs0: SUCCESS (0.354s)
[510.485303] Starting dynamic subtest: vcs0
[510.722104] Dynamic subtest vcs0: SUCCESS (0.269s)
[510.752512] Starting dynamic subtest: vecs0
[510.981744] Dynamic subtest vecs0: SUCCESS (0.257s)
[510.985324] Subtest basic-active: SUCCESS (1.529s)
[511.228480] [099/133] (550s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[511.432695] Starting subtest: primary-4-tiled-reflect-x-0
[511.440060] Subtest primary-4-tiled-reflect-x-0: SKIP (0.004s)
[511.578606] [100/133] (550s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[511.800119] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[511.808041] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[511.963359] [101/133] (550s left) kms_psr (fbc-pr-sprite-plane-move)
[512.154105] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[512.293375] [102/133] (550s left) gem_create (create-valid-nonaligned)
[512.407085] Starting subtest: create-valid-nonaligned
[512.413057] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[512.690417] [103/133] (549s left) fbdev (info)
[512.798600] Starting subtest: info
[512.802612] Subtest info: SUCCESS (0.000s)
[512.943706] [104/133] (549s left) gem_exec_suspend (basic-s3)
[513.070138] Starting subtest: basic-S3
[513.073544] Starting dynamic subtest: smem