[69.160271] Initializing watchdogs
[69.160355]   /dev/watchdog0
[69.192030] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[69.206943] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[69.212229] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[69.215687] [001/156] (960s left) kms_plane_scaling (intel-max-src-size)
[70.708549] Starting subtest: intel-max-src-size
[70.713043] Subtest intel-max-src-size: SKIP (0.004s)
[70.940489] [002/156] (958s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-fullscreen)
[72.438896] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-fullscreen
[72.441123] Subtest psrhdr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[72.623986] [003/156] (957s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[74.136050] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[74.137865] Subtest hdr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[74.321993] [004/156] (955s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[75.817973] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[78.808791] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (2.993s)
[79.022384] [005/156] (951s left) kms_addfb_basic (tile-pitch-mismatch)
[79.068132] Starting subtest: tile-pitch-mismatch
[79.069851] Subtest tile-pitch-mismatch: SKIP (0.000s)
[80.662263] [006/156] (949s left) kms_lease (atomic-implicit-crtc)
[82.165429] Starting subtest: atomic-implicit-crtc
[82.166289] Starting dynamic subtest: pipe-A-HDMI-A-4
[82.170500] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.002s)
[82.179927] Starting dynamic subtest: pipe-B-HDMI-A-4
[82.184315] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.008s)
[82.193975] Starting dynamic subtest: pipe-C-HDMI-A-4
[82.198217] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.008s)
[82.207047] Starting dynamic subtest: pipe-D-HDMI-A-4
[82.211353] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.008s)
[82.212223] Subtest atomic-implicit-crtc: SUCCESS (0.032s)
[82.368729] [007/156] (947s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[83.864908] Starting subtest: fbcpsr-rgb101010-draw-blt
[83.866831] Subtest fbcpsr-rgb101010-draw-blt: SKIP (0.000s)
[84.013218] [008/156] (946s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-pwrite)
[85.521240] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-pwrite
[85.523259] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[85.695982] [009/156] (944s left) prime_vgem (basic-fence-mmap)
[85.851410] Starting subtest: basic-fence-mmap
[85.853815] Subtest basic-fence-mmap: SKIP (0.000s)
[86.035982] [FACT prime_vgem (basic-fence-mmap)] new: kernel.kmod_is_loaded.vgem: true
[86.038284] [010/156] (944s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[86.084908] Starting subtest: invalid-multi-wait-unsubmitted
[86.085883] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[86.189131] [011/156] (944s left) kms_color (ctm-max)
[87.675355] Starting subtest: ctm-max
[87.676379] Starting dynamic subtest: pipe-A-HDMI-A-4
[88.363173] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.687s)
[88.372216] Starting dynamic subtest: pipe-B-HDMI-A-4
[88.921882] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.558s)
[88.931715] Starting dynamic subtest: pipe-C-HDMI-A-4
[89.461098] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.539s)
[89.471261] Starting dynamic subtest: pipe-D-HDMI-A-4
[89.986421] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.524s)
[89.987311] Subtest ctm-max: SUCCESS (2.310s)
[90.196914] [012/156] (940s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[90.244402] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[90.246202] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.001s)
[90.412921] [013/156] (940s left) gen9_exec_parse (bb-start-cmd)
[90.463322] Subtest bb-start-cmd: SKIP (0.000s)
[90.580922] [014/156] (940s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[92.074881] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[92.076908] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[92.237256] [015/156] (938s left) gem_mmap_wc (bad-offset)
[92.288791] Subtest bad-offset: SKIP (0.000s)
[92.360422] [016/156] (938s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[93.852249] Starting subtest: psr-rgb565-draw-mmap-cpu
[93.853910] Subtest psr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[94.034732] [017/156] (937s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[95.528292] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[95.530160] Subtest psr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[95.677580] [018/156] (935s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[97.198270] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[97.851334] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.653s)
[98.053982] [019/156] (933s left) i915_drm_fdinfo (all-busy-idle-check-all)
[98.104054] Starting subtest: all-busy-idle-check-all
[98.122964] Subtest all-busy-idle-check-all: SKIP (0.018s)
[98.245557] [020/156] (933s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-blt)
[99.777128] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-blt
[99.779119] Subtest fbchdr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[99.933230] [021/156] (931s left) kms_vblank (ts-continuation-dpms-rpm)
[101.424951] Starting subtest: ts-continuation-dpms-rpm
[101.425898] Starting dynamic subtest: pipe-A-HDMI-A-4
[103.862638] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.436s)
[103.874828] Starting dynamic subtest: pipe-D-HDMI-A-4
[105.903289] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.037s)
[105.904215] Subtest ts-continuation-dpms-rpm: SUCCESS (4.478s)
[106.104698] [022/156] (925s left) kms_dp_link_training (uhbr-sst)
[107.592101] Starting subtest: uhbr-sst
[107.593927] Subtest uhbr-sst: SKIP (0.000s)
[107.788662] [023/156] (923s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[109.284925] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[109.286833] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[109.456394] [024/156] (922s left) syncobj_wait (multi-wait-submitted)
[109.505554] Starting subtest: multi-wait-submitted
[109.614689] Subtest multi-wait-submitted: SUCCESS (0.105s)
[109.789311] [025/156] (922s left) kms_flip (2x-flip-vs-dpms-on-nop)
[111.276923] Starting subtest: 2x-flip-vs-dpms-on-nop
[111.294623] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.017s)
[111.430720] [026/156] (920s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[112.933110] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[112.935084] Subtest hdr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[113.119663] [027/156] (919s left) kms_addfb_basic (addfb25-bad-modifier)
[114.608461] Starting subtest: addfb25-bad-modifier
[114.609497] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[114.758539] [028/156] (917s left) kms_frontbuffer_tracking (fbchdr-2p-rte)
[116.262051] Starting subtest: fbchdr-2p-rte
[116.264080] Subtest fbchdr-2p-rte: SKIP (0.000s)
[116.413861] [029/156] (915s left) gem_userptr_blits (coherency-unsync)
[116.473461] Subtest coherency-unsync: SKIP (0.000s)
[116.689285] [030/156] (915s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-blt)
[118.186236] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-blt
[118.188286] Subtest psrhdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[118.364785] [031/156] (914s left) kms_properties (connector-properties-legacy)
[119.854184] Starting subtest: connector-properties-legacy
[119.855092] Starting dynamic subtest: pipe-A-HDMI-A-4
[120.619449] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.763s)
[120.630976] Starting dynamic subtest: pipe-None-DP-1
[120.632842] Dynamic subtest pipe-None-DP-1: SUCCESS (0.007s)
[120.643166] Starting dynamic subtest: pipe-None-HDMI-A-1
[120.645258] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.002s)
[120.654556] Starting dynamic subtest: pipe-None-HDMI-A-2
[120.656471] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.002s)
[120.665657] Starting dynamic subtest: pipe-None-DP-2
[120.667806] Dynamic subtest pipe-None-DP-2: SUCCESS (0.002s)
[120.676610] Starting dynamic subtest: pipe-None-HDMI-A-3
[120.678285] Dynamic subtest pipe-None-HDMI-A-3: SUCCESS (0.002s)
[120.687441] Starting dynamic subtest: pipe-None-DP-3
[120.689196] Dynamic subtest pipe-None-DP-3: SUCCESS (0.002s)
[120.690125] Subtest connector-properties-legacy: SUCCESS (0.784s)
[120.844286] [032/156] (911s left) gem_reg_read (bad-register)
[120.889944] Starting subtest: bad-register
[120.890907] Subtest bad-register: SUCCESS (0.000s)
[121.021247] [033/156] (911s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[122.512974] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[122.514603] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[122.696855] [034/156] (910s left) kms_chamelium_color (gamma)
[124.186190] Subtest gamma: SKIP (0.000s)
[124.261149] [035/156] (908s left) api_intel_bb (simple-bb-ctx)
[124.306340] Starting subtest: simple-bb-ctx
[124.330513] Subtest simple-bb-ctx: SUCCESS (0.024s)
[124.524791] [036/156] (908s left) perf_pmu (busy-accuracy-98)
[124.574899] Starting subtest: busy-accuracy-98
[124.575881] Starting dynamic subtest: rcs0
[127.625356] Dynamic subtest rcs0: SUCCESS (3.049s)
[127.636111] Starting dynamic subtest: bcs0
[130.673276] Dynamic subtest bcs0: SUCCESS (3.047s)
[130.684268] Starting dynamic subtest: vcs0
[133.719496] Dynamic subtest vcs0: SUCCESS (3.046s)
[133.730334] Starting dynamic subtest: vcs1
[136.767518] Dynamic subtest vcs1: SUCCESS (3.048s)
[136.778177] Starting dynamic subtest: vecs0
[139.814509] Dynamic subtest vecs0: SUCCESS (3.047s)
[139.815402] Subtest busy-accuracy-98: SUCCESS (15.239s)
[139.974971] [037/156] (893s left) gem_exec_schedule (smoketest-all)
[140.038363] Starting subtest: smoketest-all
[172.337254] Subtest smoketest-all: SUCCESS (32.290s)
[172.819947] [038/156] (860s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-shrfb-msflip-blt)
[174.311387] Starting subtest: fbcpsrhdr-2p-scndscrn-shrfb-msflip-blt
[174.313152] Subtest fbcpsrhdr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[174.460503] [039/156] (858s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-mmap-wc)
[175.962348] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-mmap-wc
[175.964102] Subtest hdr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[176.108030] [040/156] (857s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-fullscreen)
[177.608557] Starting subtest: hdr-1p-primscrn-spr-indfb-fullscreen
[177.610371] Subtest hdr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[177.812653] [041/156] (855s left) kms_flip (2x-busy-flip)
[179.300228] Starting subtest: 2x-busy-flip
[179.318092] Subtest 2x-busy-flip: SKIP (0.017s)
[179.444656] [042/156] (854s left) kms_frontbuffer_tracking (psr-1p-rte)
[180.946656] Starting subtest: psr-1p-rte
[180.948372] Subtest psr-1p-rte: SKIP (0.000s)
[181.136581] [043/156] (852s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[182.624329] Starting subtest: flip-vs-cursor-toggle
[197.621191] Subtest flip-vs-cursor-toggle: SUCCESS (14.998s)
[197.809334] [044/156] (835s left) kms_frontbuffer_tracking (psr-2p-rte)
[199.302613] Starting subtest: psr-2p-rte
[199.304377] Subtest psr-2p-rte: SKIP (0.000s)
[199.497165] [045/156] (834s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[201.229998] Starting subtest: cursor-rapid-movement-256x85
[201.235031] Starting dynamic subtest: pipe-A-HDMI-A-4
[201.696625] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.461s)
[201.729392] Starting dynamic subtest: pipe-D-HDMI-A-4
[202.035322] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.317s)
[202.036319] Subtest cursor-rapid-movement-256x85: SUCCESS (0.806s)
[202.402027] [046/156] (831s left) syncobj_wait (wait-for-submit-snapshot)
[202.448812] Starting subtest: wait-for-submit-snapshot
[202.532111] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[202.726160] [047/156] (831s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[204.220163] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[204.221940] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[204.391804] [048/156] (829s left) i915_hangman (hangcheck-unterminated)
[204.454988] Starting subtest: hangcheck-unterminated
[214.036598] Subtest hangcheck-unterminated: SUCCESS (9.582s)
[214.191174] [049/156] (820s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-mmap-wc)
[215.684386] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-mmap-wc
[215.686049] Subtest psrhdr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[215.861651] [050/156] (818s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[215.915659] Starting subtest: y-tiled-to-vebox-y-tiled
[215.916532] Starting dynamic subtest: smem
[216.000171] Dynamic subtest smem: SUCCESS (0.084s)
[216.011793] Starting dynamic subtest: lmem0
[216.759922] Dynamic subtest lmem0: SUCCESS (0.756s)
[216.760914] Subtest y-tiled-to-vebox-y-tiled: SUCCESS (0.841s)
[217.006391] [051/156] (817s left) gem_render_copy (linear-to-vebox-yf-tiled)
[217.059648] Starting subtest: linear-to-vebox-yf-tiled
[217.060523] Starting dynamic subtest: smem
[217.142697] Dynamic subtest smem: SUCCESS (0.083s)
[217.154254] Starting dynamic subtest: lmem0
[217.900495] Dynamic subtest lmem0: SUCCESS (0.754s)
[217.901578] Subtest linear-to-vebox-yf-tiled: SUCCESS (0.838s)
[218.160840] [052/156] (816s left) gem_create (busy-create)
[218.224169] Starting subtest: busy-create
[218.225152] Starting dynamic subtest: lmem0
[250.508205] Dynamic subtest lmem0: SUCCESS (32.285s)
[250.519821] Starting dynamic subtest: smem0
[282.772221] Dynamic subtest smem0: SUCCESS (32.263s)
[282.773145] Subtest busy-create: SUCCESS (64.549s)
[283.023944] [053/156] (751s left) kms_rotation_crc (sprite-rotation-180)
[284.510169] Starting subtest: sprite-rotation-180
[294.829446] Subtest sprite-rotation-180: SUCCESS (10.319s)
[295.092647] [054/156] (739s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[296.581959] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[296.582984] Starting dynamic subtest: pipe-A-HDMI-A-4
[296.592986] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[296.604705] Starting dynamic subtest: pipe-B-HDMI-A-4
[296.614783] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[296.626030] Starting dynamic subtest: pipe-C-HDMI-A-4
[296.637177] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[296.648420] Starting dynamic subtest: pipe-D-HDMI-A-4
[296.660135] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[296.661828] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SKIP (0.006s)
[296.864766] [055/156] (737s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[298.358884] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-mmap-cpu
[298.360846] Subtest fbchdr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[298.551149] [056/156] (736s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-move)
[300.045435] Starting subtest: fbchdr-1p-primscrn-cur-indfb-move
[300.047334] Subtest fbchdr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[300.223954] [057/156] (734s left) kms_plane (pixel-format-linear-modifier)
[301.714195] Starting subtest: pixel-format-linear-modifier
[301.744498] Starting dynamic subtest: pipe-A-plane-0
[302.778163] Dynamic subtest pipe-A-plane-0: SUCCESS (1.033s)
[302.796347] Starting dynamic subtest: pipe-A-plane-3
[303.495401] Dynamic subtest pipe-A-plane-3: SUCCESS (0.715s)
[303.510034] Starting dynamic subtest: pipe-A-plane-5
[304.228650] Dynamic subtest pipe-A-plane-5: SUCCESS (0.730s)
[304.270605] Starting dynamic subtest: pipe-A-plane-7
[304.477916] Dynamic subtest pipe-A-plane-7: SUCCESS (0.247s)
[304.671502] Starting dynamic subtest: pipe-B-plane-0
[305.577980] Dynamic subtest pipe-B-plane-0: SUCCESS (0.916s)
[305.624148] Starting dynamic subtest: pipe-B-plane-3
[306.227297] Dynamic subtest pipe-B-plane-3: SUCCESS (0.648s)
[306.241730] Starting dynamic subtest: pipe-B-plane-5
[306.944088] Dynamic subtest pipe-B-plane-5: SUCCESS (0.716s)
[306.956654] Starting dynamic subtest: pipe-B-plane-7
[307.161227] Dynamic subtest pipe-B-plane-7: SUCCESS (0.216s)
[307.249458] Subtest pixel-format-linear-modifier: SUCCESS (5.536s)
[307.489340] [058/156] (727s left) kms_psr (fbc-pr-primary-mmap-gtt)
[308.978255] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[309.052901] [059/156] (726s left) kms_addfb_basic (invalid-get-prop)
[309.099298] Starting subtest: invalid-get-prop
[309.100215] Subtest invalid-get-prop: SUCCESS (0.000s)
[310.720023] [060/156] (724s left) gem_exec_balancer (persistence)
[311.142893] Starting subtest: persistence
[313.215471] Subtest persistence: SUCCESS (2.069s)
[313.380566] [061/156] (721s left) gem_mmap_gtt (cpuset-big-copy)
[313.425538] Subtest cpuset-big-copy: SKIP (0.000s)
[313.502920] [062/156] (721s left) kms_atomic (atomic-invalid-params)
[314.990958] Starting subtest: atomic-invalid-params
[314.991956] Starting dynamic subtest: pipe-A-HDMI-A-4
[315.396545] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.405s)
[315.397440] Subtest atomic-invalid-params: SUCCESS (0.407s)
[315.599942] [063/156] (719s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[317.091134] Starting subtest: cursorB-vs-flipA-varying-size
[317.094101] Subtest cursorB-vs-flipA-varying-size: SKIP (0.002s)
[317.223328] [064/156] (718s left) gen7_exec_parse (basic-allowed)
[317.287030] Subtest basic-allowed: SKIP (0.000s)
[317.372218] [065/156] (718s left) kms_busy (extended-modeset-hang-oldfb)
[318.867229] Starting subtest: extended-modeset-hang-oldfb
[318.868178] Starting dynamic subtest: pipe-A
[326.809171] Dynamic subtest pipe-A: SUCCESS (7.942s)
[326.824116] Starting dynamic subtest: pipe-D
[334.720331] Dynamic subtest pipe-D: SUCCESS (7.907s)
[334.721301] Subtest extended-modeset-hang-oldfb: SUCCESS (15.855s)
[334.939803] [066/156] (700s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[336.433931] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[336.435732] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[336.609546] [067/156] (699s left) gem_mmap_offset (partial-unmap)
[336.657212] Starting subtest: partial-unmap
[336.658178] Starting dynamic subtest: lmem0
[336.666130] Dynamic subtest lmem0: SUCCESS (0.009s)
[336.678646] Starting dynamic subtest: smem0
[336.679797] Dynamic subtest smem0: SUCCESS (0.006s)
[336.680975] Subtest partial-unmap: SUCCESS (0.017s)
[336.811388] [068/156] (699s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[338.305176] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[338.306772] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[338.492207] [069/156] (697s left) kms_universal_plane (universal-plane-pageflip-windowed)
[339.982105] Starting subtest: universal-plane-pageflip-windowed
[339.982958] Starting dynamic subtest: pipe-A-HDMI-A-4
[340.519384] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.537s)
[340.532505] Starting dynamic subtest: pipe-B-HDMI-A-4
[340.902933] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.381s)
[340.916321] Starting dynamic subtest: pipe-C-HDMI-A-4
[341.289135] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.385s)
[341.304722] Starting dynamic subtest: pipe-D-HDMI-A-4
[341.679940] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.387s)
[341.680930] Subtest universal-plane-pageflip-windowed: SUCCESS (1.699s)
[341.894009] [070/156] (694s left) gem_exec_whisper (basic-fds-priority-all)
[341.954308] Starting subtest: basic-fds-priority-all
[354.239272] Subtest basic-fds-priority-all: SUCCESS (12.285s)
[354.564304] [071/156] (681s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-fullscreen)
[356.058266] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-fullscreen
[356.060258] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[356.262502] [072/156] (679s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[357.764570] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[357.766719] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[357.944270] [073/156] (678s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[361.957554] Starting subtest: gem-execbuf-stress-pc8
[362.041550] Subtest gem-execbuf-stress-pc8: SKIP (0.081s)
[362.943230] [074/156] (673s left) kms_draw_crc (draw-method-render)
[364.432316] Starting subtest: draw-method-render
[364.433199] Starting dynamic subtest: xrgb8888-untiled
[364.847678] Dynamic subtest xrgb8888-untiled: SUCCESS (0.414s)
[364.893394] Starting dynamic subtest: rgb565-untiled
[365.197836] Dynamic subtest rgb565-untiled: SUCCESS (0.345s)
[365.244205] Starting dynamic subtest: xrgb2101010-untiled
[365.547794] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.345s)
[365.594130] Starting dynamic subtest: xbgr16161616f-untiled
[365.931238] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.378s)
[365.978574] Starting dynamic subtest: xrgb8888-xtiled
[366.130977] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.195s)
[366.147441] Starting dynamic subtest: rgb565-xtiled
[366.297535] Dynamic subtest rgb565-xtiled: SUCCESS (0.161s)
[366.333260] Starting dynamic subtest: xrgb2101010-xtiled
[366.464231] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.160s)
[366.512332] Starting dynamic subtest: xbgr16161616f-xtiled
[366.662575] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.194s)
[366.678168] Starting dynamic subtest: xrgb8888-ytiled
[366.830910] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.166s)
[366.878266] Starting dynamic subtest: rgb565-ytiled
[367.030907] Dynamic subtest rgb565-ytiled: SUCCESS (0.195s)
[367.078610] Starting dynamic subtest: xrgb2101010-ytiled
[367.214168] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.178s)
[367.258819] Starting dynamic subtest: xbgr16161616f-ytiled
[367.414326] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.195s)
[367.421279] Subtest draw-method-render: SUCCESS (2.984s)
[367.695547] [075/156] (668s left) gem_exec_balancer (bonded-semaphore)
[367.752271] Starting subtest: bonded-semaphore
[367.754208] Subtest bonded-semaphore: SKIP (0.000s)
[368.183339] [076/156] (668s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[369.676071] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[369.677733] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (0.000s)
[369.786796] [077/156] (666s left) perf_pmu (multi-client)
[369.844304] Starting subtest: multi-client
[369.845311] Starting dynamic subtest: rcs0
[370.918654] Dynamic subtest rcs0: SUCCESS (1.070s)
[370.930788] Starting dynamic subtest: bcs0
[371.972669] Dynamic subtest bcs0: SUCCESS (1.049s)
[371.984710] Starting dynamic subtest: vcs0
[373.026254] Dynamic subtest vcs0: SUCCESS (1.049s)
[373.038560] Starting dynamic subtest: vcs1
[374.080368] Dynamic subtest vcs1: SUCCESS (1.049s)
[374.092649] Starting dynamic subtest: vecs0
[375.135119] Dynamic subtest vecs0: SUCCESS (1.050s)
[375.136155] Subtest multi-client: SUCCESS (5.290s)
[375.328978] [078/156] (661s left) gem_eio (create)
[375.499153] Starting subtest: create
[375.723514] Subtest create: SUCCESS (0.224s)
[377.285663] [079/156] (659s left) kms_big_fb (linear-16bpp-rotate-0)
[378.799399] Starting subtest: linear-16bpp-rotate-0
[380.751040] Subtest linear-16bpp-rotate-0: SUCCESS (1.947s)
[380.976945] [080/156] (656s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[382.466328] Starting subtest: addfb25-y-tiled-legacy
[382.467241] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[382.642615] [081/156] (654s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[382.690305] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[382.798753] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.104s)
[383.008124] [082/156] (654s left) kms_psr (psr2-cursor-mmap-gtt)
[384.496936] Subtest psr2-cursor-mmap-gtt: SKIP (0.000s)
[384.574470] [083/156] (652s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[386.081124] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[386.082977] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[386.330097] [084/156] (651s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[387.817406] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[387.818350] Starting dynamic subtest: pipe-A-HDMI-A-4
[387.822164] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[387.834700] Starting dynamic subtest: pipe-B-HDMI-A-4
[387.838482] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[387.851146] Starting dynamic subtest: pipe-C-HDMI-A-4
[387.855132] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[387.867220] Starting dynamic subtest: pipe-D-HDMI-A-4
[387.871153] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[387.873091] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SKIP (0.009s)
[388.098557] [085/156] (649s left) kms_hdr (bpc-switch-dpms)
[389.587453] Starting subtest: bpc-switch-dpms
[389.588429] Starting dynamic subtest: pipe-A-HDMI-A-4-XRGB2101010
[389.590267] Dynamic subtest pipe-A-HDMI-A-4-XRGB2101010: SKIP (0.000s)
[389.602976] Starting dynamic subtest: pipe-A-HDMI-A-4-XRGB16161616F
[389.605368] Dynamic subtest pipe-A-HDMI-A-4-XRGB16161616F: SKIP (0.000s)
[389.607627] Subtest bpc-switch-dpms: SKIP (0.006s)
[389.719775] [086/156] (647s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[391.210126] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[391.289945] [087/156] (646s left) kms_frontbuffer_tracking (hdr-rgb565-draw-render)
[392.783900] Starting subtest: hdr-rgb565-draw-render
[392.785644] Subtest hdr-rgb565-draw-render: SKIP (0.000s)
[392.980852] [088/156] (644s left) kms_plane_scaling (planes-upscale-20x20)
[394.470523] Starting subtest: planes-upscale-20x20
[394.471479] Starting dynamic subtest: pipe-A
[394.592288] Dynamic subtest pipe-A: SUCCESS (0.122s)
[394.609289] Starting dynamic subtest: pipe-B
[394.751112] Dynamic subtest pipe-B: SUCCESS (0.158s)
[394.763359] Starting dynamic subtest: pipe-C
[394.908189] Dynamic subtest pipe-C: SUCCESS (0.156s)
[394.922034] Starting dynamic subtest: pipe-D
[395.064691] Dynamic subtest pipe-D: SUCCESS (0.155s)
[395.065629] Subtest planes-upscale-20x20: SUCCESS (0.596s)
[395.258364] [089/156] (642s left) kms_lease (lease-revoke)
[396.771883] Starting subtest: lease-revoke
[396.772936] Starting dynamic subtest: pipe-A-HDMI-A-4
[396.840832] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.068s)
[396.855284] Starting dynamic subtest: pipe-B-HDMI-A-4
[396.889790] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.048s)
[396.904086] Starting dynamic subtest: pipe-C-HDMI-A-4
[396.939484] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.048s)
[396.953269] Starting dynamic subtest: pipe-D-HDMI-A-4
[396.989637] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.048s)
[396.990638] Subtest lease-revoke: SUCCESS (0.220s)
[397.184656] [090/156] (640s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[398.674498] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[398.677688] Starting dynamic subtest: pipe-A-HDMI-A-4
[398.685808] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[398.698230] Starting dynamic subtest: pipe-B-HDMI-A-4
[398.706433] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[398.718461] Starting dynamic subtest: pipe-C-HDMI-A-4
[398.726596] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[398.738413] Starting dynamic subtest: pipe-D-HDMI-A-4
[398.746767] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[398.748352] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SKIP (0.009s)
[398.954286] [091/156] (639s left) kms_getfb (getfb-handle-closed)
[400.442523] Starting subtest: getfb-handle-closed
[400.443422] Subtest getfb-handle-closed: SUCCESS (0.000s)
[400.640249] [092/156] (637s left) kms_frontbuffer_tracking (fbc-2p-rte)
[402.133984] Starting subtest: fbc-2p-rte
[402.136049] Subtest fbc-2p-rte: SKIP (0.000s)
[402.316315] [093/156] (635s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-pwrite)
[403.809868] Starting subtest: fbcpsrhdr-rgb101010-draw-pwrite
[403.811824] Subtest fbcpsrhdr-rgb101010-draw-pwrite: SKIP (0.000s)
[403.999423] [094/156] (634s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[405.493943] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu
[405.495969] Subtest psrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[405.687159] [095/156] (632s left) gem_softpin (softpin)
[405.739909] Starting subtest: softpin
[438.227665] Subtest softpin: SUCCESS (32.482s)
[438.376396] [096/156] (600s left) kms_cursor_crc (cursor-offscreen-128x42)
[440.058954] Starting subtest: cursor-offscreen-128x42
[440.065398] Starting dynamic subtest: pipe-A-HDMI-A-4
[442.588668] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.523s)
[442.623917] Starting dynamic subtest: pipe-D-HDMI-A-4
[444.966557] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.354s)
[444.967538] Subtest cursor-offscreen-128x42: SUCCESS (4.907s)
[445.385199] [097/156] (593s left) kms_properties (crtc-properties-legacy)
[446.873226] Starting subtest: crtc-properties-legacy
[446.874106] Starting dynamic subtest: pipe-A-HDMI-A-4
[447.204798] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.330s)
[447.229168] Starting dynamic subtest: pipe-B-HDMI-A-4
[447.495284] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.286s)
[447.510257] Starting dynamic subtest: pipe-C-HDMI-A-4
[447.794967] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.296s)
[447.808916] Starting dynamic subtest: pipe-D-HDMI-A-4
[448.082388] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.286s)
[448.083316] Subtest crtc-properties-legacy: SUCCESS (1.210s)
[448.290131] [098/156] (590s left) kms_chamelium_hpd (hdmi-hpd)
[449.822963] Subtest hdmi-hpd: SKIP (0.000s)
[449.951831] [099/156] (588s left) kms_pm_rpm (dpms-non-lpsp)
[454.068499] Starting subtest: dpms-non-lpsp
[454.176472] Subtest dpms-non-lpsp: SUCCESS (0.109s)
[455.035759] [100/156] (583s left) gem_exec_schedule (u-semaphore-noskip)
[455.108998] Starting subtest: u-semaphore-noskip
[455.496754] Subtest u-semaphore-noskip: SUCCESS (0.385s)
[455.974025] [101/156] (583s left) prime_busy (hang-wait)
[456.032325] Starting subtest: hang-wait
[456.034913] Starting dynamic subtest: rcs0
[482.422515] Dynamic subtest rcs0: SUCCESS (26.387s)
[482.434984] Starting dynamic subtest: bcs0
[489.569764] Dynamic subtest bcs0: SUCCESS (7.147s)
[489.583933] Starting dynamic subtest: vcs0
[496.551666] Dynamic subtest vcs0: SUCCESS (6.979s)
[496.564241] Starting dynamic subtest: vcs1
[503.588516] Dynamic subtest vcs1: SUCCESS (7.035s)
[503.600952] Starting dynamic subtest: vecs0
[510.563616] Dynamic subtest vecs0: SUCCESS (6.974s)
[510.564515] Subtest hang-wait: SUCCESS (54.531s)
[510.711361] [102/156] (528s left) gem_basic (multigpu-create-close)
[510.758896] Starting subtest: multigpu-create-close
[510.760985] Subtest multigpu-create-close: SKIP (0.000s)
[510.899888] [103/156] (528s left) kms_flip (2x-plain-flip-interruptible)
[512.393641] Starting subtest: 2x-plain-flip-interruptible
[512.412161] Subtest 2x-plain-flip-interruptible: SKIP (0.018s)
[512.540070] [104/156] (526s left) kms_plane_alpha_blend (constant-alpha-mid)
[514.032183] Starting subtest: constant-alpha-mid
[514.295369] Starting dynamic subtest: pipe-A-HDMI-A-4
[514.997833] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.701s)
[515.011416] Starting dynamic subtest: pipe-D-HDMI-A-4
[515.698013] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.698s)
[515.698916] Subtest constant-alpha-mid: SUCCESS (1.667s)
[515.915754] [105/156] (523s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[517.410139] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-wc
[517.412117] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[517.555883] [106/156] (521s left) drm_read (short-buffer-wakeup)
[519.119750] Starting subtest: short-buffer-wakeup
[551.335813] Subtest short-buffer-wakeup: SUCCESS (32.214s)
[551.585880] [107/156] (487s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[553.093940] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[554.189096] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.091s)
[554.379158] [108/156] (485s left) syncobj_wait (single-wait-submitted)
[554.427118] Starting subtest: single-wait-submitted
[554.532527] Subtest single-wait-submitted: SUCCESS (0.103s)
[554.654602] [109/156] (485s left) kms_scaling_modes (scaling-mode-full)
[556.146825] Starting subtest: scaling-mode-full
[556.151972] Subtest scaling-mode-full: SKIP (0.001s)
[556.255690] [110/156] (483s left) sysfs_timeslice_duration (invalid)
[556.309864] Starting subtest: invalid
[556.312302] Starting dynamic subtest: vecs0
[556.313253] Dynamic subtest vecs0: SUCCESS (0.000s)
[556.326060] Starting dynamic subtest: vcs0
[556.327141] Dynamic subtest vcs0: SUCCESS (0.000s)
[556.339529] Starting dynamic subtest: bcs0
[556.340595] Dynamic subtest bcs0: SUCCESS (0.001s)
[556.352515] Starting dynamic subtest: rcs0
[556.353584] Dynamic subtest rcs0: SUCCESS (0.000s)
[556.365852] Starting dynamic subtest: vcs1
[556.366810] Dynamic subtest vcs1: SUCCESS (0.000s)
[556.367838] Subtest invalid: SUCCESS (0.012s)
[556.453296] [111/156] (483s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[556.500150] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[556.605630] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.102s)
[556.728223] [112/156] (483s left) gem_exec_reloc (basic-wc)
[556.779669] Subtest basic-wc: SKIP (0.000s)
[556.886525] [113/156] (483s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[556.936491] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[557.064758] [114/156] (483s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[558.558383] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[558.560382] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[558.721535] [115/156] (481s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs)
[560.212526] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs
[560.213510] Starting dynamic subtest: pipe-A-HDMI-A-4
[560.222297] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[560.234840] Starting dynamic subtest: pipe-B-HDMI-A-4
[560.243905] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[560.256238] Starting dynamic subtest: pipe-C-HDMI-A-4
[560.265883] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[560.278027] Starting dynamic subtest: pipe-D-HDMI-A-4
[560.287472] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[560.289308] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.010s)
[560.498677] [116/156] (479s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[561.992762] Starting subtest: fbc-farfromfence-mmap-gtt
[561.994435] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[562.180651] [117/156] (478s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[563.677163] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[563.679294] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[563.859548] [118/156] (476s left) i915_suspend (basic-s2idle-without-i915)
[563.905181] Starting subtest: basic-s2idle-without-i915
[585.077467] Subtest basic-s2idle-without-i915: SUCCESS (5.629s)
[587.226835] [119/156] (455s left) gem_exec_schedule (implicit-boths)
[587.294091] Starting subtest: implicit-boths
[587.295029] Starting dynamic subtest: rcs0
[587.508427] Dynamic subtest rcs0: SUCCESS (0.210s)
[587.520886] Starting dynamic subtest: bcs0
[587.646832] Dynamic subtest bcs0: SUCCESS (0.140s)
[587.660866] Starting dynamic subtest: vcs0
[587.788770] Dynamic subtest vcs0: SUCCESS (0.141s)
[587.802502] Starting dynamic subtest: vcs1
[587.944615] Dynamic subtest vcs1: SUCCESS (0.154s)
[587.960510] Starting dynamic subtest: vecs0
[588.098447] Dynamic subtest vecs0: SUCCESS (0.153s)
[588.099308] Subtest implicit-boths: SUCCESS (0.806s)
[588.575023] [120/156] (454s left) gem_ctx_param (invalid-ctx-set)
[588.619852] Starting subtest: invalid-ctx-set
[588.620627] Subtest invalid-ctx-set: SUCCESS (0.001s)
[588.758516] [121/156] (454s left) gem_exec_reloc (basic-gtt-noreloc)
[588.809236] Subtest basic-gtt-noreloc: SKIP (0.000s)
[588.918966] [122/156] (453s left) kms_cursor_edge_walk (256x256-top-bottom)
[590.393462] Starting subtest: 256x256-top-bottom
[590.396585] Starting dynamic subtest: pipe-A-HDMI-A-4
[593.708640] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (3.341s)
[593.724935] Starting dynamic subtest: pipe-D-HDMI-A-4
[596.936921] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (3.242s)
[596.937878] Subtest 256x256-top-bottom: SUCCESS (6.589s)
[597.146458] [123/156] (445s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[597.725853] Starting subtest: syncobj-timeline-multiple-ext-nodes
[597.726796] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.003s)
[598.046321] [124/156] (444s left) api_intel_allocator (alloc-simple)
[598.090847] Starting subtest: alloc-simple
[598.108492] Subtest alloc-simple: SUCCESS (0.018s)
[598.324744] [125/156] (444s left) gem_shrink (reclaim)
[598.384390] Starting subtest: reclaim
[600.654761] Subtest reclaim: SUCCESS (2.273s)
[600.873604] [126/156] (442s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier-source-clamping)
[602.359423] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier-source-clamping
[602.361009] Subtest pixel-format-4-tiled-bmg-ccs-modifier-source-clamping: SKIP (0.000s)
[602.478167] [127/156] (440s left) kms_psr (fbc-psr2-primary-page-flip)
[603.971528] Subtest fbc-psr2-primary-page-flip: SKIP (0.000s)
[604.057656] [128/156] (439s left) kms_force_connector_basic (force-edid)
[604.188895] Starting subtest: force-edid
[604.208981] Subtest force-edid: SUCCESS (0.022s)
[605.861274] [129/156] (437s left) syncobj_timeline (wait-any-snapshot)
[605.911411] Starting subtest: wait-any-snapshot
[605.995207] Subtest wait-any-snapshot: SUCCESS (0.083s)
[606.212567] [130/156] (437s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-move)
[607.704805] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-move
[607.706875] Subtest psrhdr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[607.887418] [131/156] (435s left) gem_ctx_param (invalid-get-ringsize)
[607.950575] Starting subtest: invalid-get-ringsize
[607.951609] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[608.076711] [132/156] (435s left) gem_sync (basic-store-all)
[608.135146] Starting subtest: basic-store-all
[610.403094] Subtest basic-store-all: SUCCESS (2.271s)
[610.659064] [133/156] (433s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[610.705369] Starting subtest: multi-wait-all-for-submit-available-signaled
[610.706320] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.001s)
[610.837560] [134/156] (433s left) kms_prime (d3hot)
[612.344932] Subtest D3hot: SKIP (0.000s)
[612.565733] [135/156] (431s left) kms_psr (psr2-primary-mmap-cpu)
[614.053002] Subtest psr2-primary-mmap-cpu: SKIP (0.000s)
[614.128414] [136/156] (430s left) kms_frontbuffer_tracking (fbchdr-farfromfence-mmap-gtt)
[615.623857] Starting subtest: fbchdr-farfromfence-mmap-gtt
[615.625550] Subtest fbchdr-farfromfence-mmap-gtt: SKIP (0.000s)
[615.825436] [137/156] (428s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[617.314160] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[617.332392] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.017s)
[617.460199] [138/156] (426s left) sw_sync (alloc_fence_invalid_timeline)
[617.510368] Starting subtest: alloc_fence_invalid_timeline
[617.511409] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[617.630321] [139/156] (426s left) gem_partial_pwrite_pread (write-snoop)
[617.681320] Subtest write-snoop: SKIP (0.000s)
[617.783587] [140/156] (426s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[619.272412] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.000s)
[619.359699] [141/156] (425s left) gem_exec_schedule (pi-userfault)
[619.581178] Starting subtest: pi-userfault
[619.585376] Starting dynamic subtest: rcs0
[619.598734] Dynamic subtest rcs0: SUCCESS (0.016s)
[619.620480] Starting dynamic subtest: bcs0
[619.621505] Dynamic subtest bcs0: SUCCESS (0.012s)
[619.640039] Starting dynamic subtest: vcs0
[619.641028] Dynamic subtest vcs0: SUCCESS (0.012s)
[619.654517] Starting dynamic subtest: vcs1
[619.655577] Dynamic subtest vcs1: SUCCESS (0.012s)
[619.668328] Starting dynamic subtest: vecs0
[619.669357] Dynamic subtest vecs0: SUCCESS (0.008s)
[619.670495] Subtest pi-userfault: SUCCESS (0.072s)
[619.948073] [142/156] (424s left) kms_content_protection (dp-mst-type-1-suspend-resume)
[621.498647] Starting subtest: dp-mst-type-1-suspend-resume
[621.500786] Subtest dp-mst-type-1-suspend-resume: SKIP (0.000s)
[621.696029] [143/156] (423s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[623.189692] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[623.191342] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[623.418572] [144/156] (421s left) gem_spin_batch (legacy)
[623.476401] Starting subtest: legacy
[623.478934] Starting dynamic subtest: default
[626.731616] Dynamic subtest default: SUCCESS (3.248s)
[626.747999] Starting dynamic subtest: render
[629.967459] Dynamic subtest render: SUCCESS (3.228s)
[629.987707] Starting dynamic subtest: bsd
[633.209358] Dynamic subtest bsd: SUCCESS (3.234s)
[633.224663] Starting dynamic subtest: bsd1
[636.446358] Dynamic subtest bsd1: SUCCESS (3.230s)
[636.462523] Starting dynamic subtest: bsd2
[639.684065] Dynamic subtest bsd2: SUCCESS (3.230s)
[639.703324] Starting dynamic subtest: blt
[642.925145] Dynamic subtest blt: SUCCESS (3.234s)
[642.941433] Starting dynamic subtest: vebox
[646.164250] Dynamic subtest vebox: SUCCESS (3.230s)
[646.166443] Subtest legacy: SUCCESS (22.690s)
[646.444504] [145/156] (398s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[647.954277] Starting subtest: 4-tiled-64bpp-rotate-180
[647.956229] Subtest 4-tiled-64bpp-rotate-180: SKIP (0.000s)
[648.099880] [146/156] (397s left) i915_query (query-topology-kernel-writes)
[648.149287] Starting subtest: query-topology-kernel-writes
[648.150122] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[648.261217] [147/156] (396s left) gem_ctx_persistence (heartbeat-many)
[648.313987] Starting subtest: heartbeat-many
[648.315901] Subtest heartbeat-many: SKIP (0.000s)
[648.426522] [148/156] (396s left) gem_madvise (dontneed-after-mmap)
[648.470208] Starting subtest: dontneed-after-mmap
[648.475019] Subtest dontneed-after-mmap: SUCCESS (0.004s)
[648.642389] [149/156] (396s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[650.129970] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[650.130961] Starting dynamic subtest: pipe-A-HDMI-A-4
[652.550057] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.413s)
[652.590688] Starting dynamic subtest: pipe-B-HDMI-A-4
[653.522069] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.961s)
[653.564524] Starting dynamic subtest: pipe-C-HDMI-A-4
[654.463184] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.929s)
[654.504611] Starting dynamic subtest: pipe-D-HDMI-A-4
[655.386744] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.911s)
[655.389065] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SUCCESS (5.256s)
[655.641028] [150/156] (389s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[657.148481] Starting subtest: y-tiled-32bpp-rotate-270
[659.166156] Subtest y-tiled-32bpp-rotate-270: SUCCESS (2.014s)
[659.410965] [151/156] (386s left) gem_lmem_swapping (heavy-verify-multi)
[663.718361] Starting subtest: heavy-verify-multi
[663.719718] Starting dynamic subtest: lmem0
[680.307481] Dynamic subtest lmem0: SUCCESS (16.592s)
[680.308531] Subtest heavy-verify-multi: SUCCESS (16.594s)
[681.632553] [FACT gem_lmem_swapping (heavy-verify-multi)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[681.633704] [FACT gem_lmem_swapping (heavy-verify-multi)] deleted: kernel.kmod_is_loaded.i915: true
[681.636676] [152/156] (363s left) gem_eio (wait-wedge-immediate)
[685.007563] Starting subtest: wait-wedge-immediate
[686.434056] Subtest wait-wedge-immediate: SUCCESS (1.426s)
[687.948924] [FACT gem_eio (wait-wedge-immediate)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[687.952252] [FACT gem_eio (wait-wedge-immediate)] new: kernel.kmod_is_loaded.i915: true
[687.955720] [153/156] (357s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[688.003535] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[688.089132] [154/156] (357s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[689.598148] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[689.671855] [155/156] (356s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-indfb-pgflip-blt)
[691.167006] Starting subtest: hdr-2p-scndscrn-indfb-pgflip-blt
[691.168954] Subtest hdr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[691.347271] [156/156] (354s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[692.842201] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[692.844063] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[693.017225] Closing watchdogs
results: parsing output: 0/ for test: kms_plane_scaling
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_addfb_basic
results: parsing output: 5/ for test: kms_lease
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: prime_vgem
results: parsing output: 9/ for test: syncobj_wait
results: parsing output: 10/ for test: kms_color
results: parsing output: 11/ for test: syncobj_timeline
results: parsing output: 12/ for test: gen9_exec_parse
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: gem_mmap_wc
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_big_fb
results: parsing output: 18/ for test: i915_drm_fdinfo
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_vblank
results: parsing output: 21/ for test: kms_dp_link_training
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: syncobj_wait
results: parsing output: 24/ for test: kms_flip
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_addfb_basic
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: gem_userptr_blits
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_properties
results: parsing output: 31/ for test: gem_reg_read
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_chamelium_color
results: parsing output: 34/ for test: api_intel_bb
results: parsing output: 35/ for test: perf_pmu
results: parsing output: 36/ for test: gem_exec_schedule
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_flip
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_cursor_legacy
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_cursor_crc
results: parsing output: 45/ for test: syncobj_wait
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: i915_hangman
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: gem_render_copy
results: parsing output: 50/ for test: gem_render_copy
results: parsing output: 51/ for test: gem_create
results: parsing output: 52/ for test: kms_rotation_crc
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_plane
results: parsing output: 57/ for test: kms_psr
results: parsing output: 58/ for test: kms_addfb_basic
results: parsing output: 59/ for test: gem_exec_balancer
results: parsing output: 60/ for test: gem_mmap_gtt
results: parsing output: 61/ for test: kms_atomic
results: parsing output: 62/ for test: kms_cursor_legacy
results: parsing output: 63/ for test: gen7_exec_parse
results: parsing output: 64/ for test: kms_busy
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_mmap_offset
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_universal_plane
results: parsing output: 69/ for test: gem_exec_whisper
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: i915_pm_rpm
results: parsing output: 73/ for test: kms_draw_crc
results: parsing output: 74/ for test: gem_exec_balancer
results: parsing output: 75/ for test: kms_flip_scaled_crc
results: parsing output: 76/ for test: perf_pmu
results: parsing output: 77/ for test: gem_eio
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: kms_addfb_basic
results: parsing output: 80/ for test: syncobj_timeline
results: parsing output: 81/ for test: kms_psr
results: parsing output: 82/ for test: kms_big_fb
results: parsing output: 83/ for test: kms_ccs
results: parsing output: 84/ for test: kms_hdr
results: parsing output: 85/ for test: kms_psr2_sf
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_plane_scaling
results: parsing output: 88/ for test: kms_lease
results: parsing output: 89/ for test: kms_ccs
results: parsing output: 90/ for test: kms_getfb
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: gem_softpin
results: parsing output: 95/ for test: kms_cursor_crc
results: parsing output: 96/ for test: kms_properties
results: parsing output: 97/ for test: kms_chamelium_hpd
results: parsing output: 98/ for test: kms_pm_rpm
results: parsing output: 99/ for test: gem_exec_schedule
results: parsing output: 100/ for test: prime_busy
results: parsing output: 101/ for test: gem_basic
results: parsing output: 102/ for test: kms_flip
results: parsing output: 103/ for test: kms_plane_alpha_blend
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: drm_read
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: syncobj_wait
results: parsing output: 108/ for test: kms_scaling_modes
results: parsing output: 109/ for test: sysfs_timeslice_duration
results: parsing output: 110/ for test: syncobj_timeline
results: parsing output: 111/ for test: gem_exec_reloc
results: parsing output: 112/ for test: gem_exec_reloc
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_ccs
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: i915_suspend
results: parsing output: 118/ for test: gem_exec_schedule
results: parsing output: 119/ for test: gem_ctx_param
results: parsing output: 120/ for test: gem_exec_reloc
results: parsing output: 121/ for test: kms_cursor_edge_walk
results: parsing output: 122/ for test: gem_exec_fence
results: parsing output: 123/ for test: api_intel_allocator
results: parsing output: 124/ for test: gem_shrink
results: parsing output: 125/ for test: kms_plane
results: parsing output: 126/ for test: kms_psr
results: parsing output: 127/ for test: kms_force_connector_basic
results: parsing output: 128/ for test: syncobj_timeline
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: gem_ctx_param
results: parsing output: 131/ for test: gem_sync
results: parsing output: 132/ for test: syncobj_timeline
results: parsing output: 133/ for test: kms_prime
results: parsing output: 134/ for test: kms_psr
results: parsing output: 135/ for test: kms_frontbuffer_tracking
results: parsing output: 136/ for test: kms_flip
results: parsing output: 137/ for test: sw_sync
results: parsing output: 138/ for test: gem_partial_pwrite_pread
results: parsing output: 139/ for test: kms_psr
results: parsing output: 140/ for test: gem_exec_schedule
results: parsing output: 141/ for test: kms_content_protection
results: parsing output: 142/ for test: kms_frontbuffer_tracking
results: parsing output: 143/ for test: gem_spin_batch
results: parsing output: 144/ for test: kms_big_fb
results: parsing output: 145/ for test: i915_query
results: parsing output: 146/ for test: gem_ctx_persistence
results: parsing output: 147/ for test: gem_madvise
results: parsing output: 148/ for test: kms_ccs
results: parsing output: 149/ for test: kms_big_fb
results: parsing output: 150/ for test: gem_lmem_swapping
results: parsing output: 151/ for test: gem_eio
results: parsing output: 152/ for test: kms_pipe_b_c_ivb
results: parsing output: 153/ for test: kms_psr2_sf
results: parsing output: 154/ for test: kms_frontbuffer_tracking
results: parsing output: 155/ for test: kms_frontbuffer_tracking
Done.