[57.000330] Initializing watchdogs
[57.000376]   /dev/watchdog0
[57.013777] [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]
[57.018139] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.020222] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.024116] [001/133] (960s left) perf_pmu (render-node-busy)
[57.116722] Starting subtest: render-node-busy
[57.119200] Starting dynamic subtest: rcs0
[57.696059] Dynamic subtest rcs0: SUCCESS (0.583s)
[57.706086] Starting dynamic subtest: bcs0
[58.255552] Dynamic subtest bcs0: SUCCESS (0.561s)
[58.265738] Starting dynamic subtest: vcs0
[59.925267] Dynamic subtest vcs0: SUCCESS (1.676s)
[59.935568] Starting dynamic subtest: vcs1
[61.909071] Dynamic subtest vcs1: SUCCESS (1.990s)
[61.917293] Starting dynamic subtest: vecs0
[63.893131] Dynamic subtest vecs0: SUCCESS (1.989s)
[63.902904] Starting dynamic subtest: ccs0
[64.459337] Dynamic subtest ccs0: SUCCESS (0.568s)
[64.461880] Subtest render-node-busy: SUCCESS (7.376s)
[64.544054] [002/133] (953s left) gem_exec_schedule (fairslice-all)
[64.614755] Starting subtest: fairslice-all
[66.705417] Subtest fairslice-all: SUCCESS (2.100s)
[67.074841] [003/133] (950s left) gem_eio (wait-immediate)
[67.365970] Starting subtest: wait-immediate
[67.911442] Subtest wait-immediate: SUCCESS (0.549s)
[68.163761] [004/133] (949s left) gem_ctx_engines (execute-oneforall)
[68.219828] Starting subtest: execute-oneforall
[68.894896] Subtest execute-oneforall: SUCCESS (0.674s)
[70.025286] [005/133] (947s left) gem_exec_flush (basic-uc-pro-default)
[70.088564] Starting subtest: basic-uc-pro-default
[75.534856] Subtest basic-uc-pro-default: SUCCESS (5.453s)
[75.721161] [006/133] (942s left) gem_ctx_shared (q-in-order)
[75.781856] Starting subtest: Q-in-order
[75.784594] Starting dynamic subtest: rcs0
[75.980032] Dynamic subtest rcs0: SUCCESS (0.196s)
[75.994569] Starting dynamic subtest: vcs0
[76.093225] Dynamic subtest vcs0: SUCCESS (0.114s)
[76.110808] Starting dynamic subtest: vcs1
[76.204406] Dynamic subtest vcs1: SUCCESS (0.111s)
[76.220155] Starting dynamic subtest: vecs0
[76.313829] Dynamic subtest vecs0: SUCCESS (0.110s)
[76.329709] Starting dynamic subtest: ccs0
[76.444332] Dynamic subtest ccs0: SUCCESS (0.128s)
[76.446782] Subtest Q-in-order: SUCCESS (0.662s)
[78.022646] [FACT gem_ctx_shared (q-in-order)] new: kernel.kmod_is_loaded.vgem: true
[78.025702] [007/133] (939s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[78.136963] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[78.148088] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.010s)
[78.221648] [008/133] (939s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[78.316038] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[82.737974] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.426s)
[83.941212] [009/133] (933s left) kms_psr (pr-sprite-mmap-cpu)
[84.043352] Starting subtest: pr-sprite-mmap-cpu
[84.047945] Subtest pr-sprite-mmap-cpu: SKIP (0.000s)
[84.114549] [010/133] (933s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[84.511634] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[85.353956] [011/133] (932s left) kms_vblank (ts-continuation-modeset-hang)
[85.452860] Starting subtest: ts-continuation-modeset-hang
[85.454843] Starting dynamic subtest: pipe-A-eDP-1
[111.648408] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.195s)
[111.663783] Starting dynamic subtest: pipe-D-eDP-1
[136.667010] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.015s)
[136.669400] Subtest ts-continuation-modeset-hang: SUCCESS (51.213s)
[137.508758] [012/133] (880s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[137.633470] Starting subtest: cursorA-vs-flipB-varying-size
[137.638313] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[137.780362] [013/133] (880s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier)
[137.869656] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier
[137.873779] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier: SKIP (0.000s)
[137.955807] [014/133] (880s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[138.053035] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[139.086950] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.034s)
[139.209614] [015/133] (878s left) kms_pm_rpm (dpms-non-lpsp)
[141.039574] Starting subtest: dpms-non-lpsp
[141.045316] Subtest dpms-non-lpsp: SKIP (0.001s)
[141.447630] [016/133] (876s left) kms_frontbuffer_tracking (psr-2p-rte)
[141.553778] Starting subtest: psr-2p-rte
[141.558163] Subtest psr-2p-rte: SKIP (0.000s)
[141.632891] [017/133] (876s left) gem_exec_reloc (basic-wc-noreloc)
[141.699133] Subtest basic-wc-noreloc: SKIP (0.000s)
[141.776025] [018/133] (876s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[141.884818] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf
[141.889256] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[141.950407] [019/133] (876s left) i915_hangman (gt-engine-hang)
[142.014084] Starting subtest: gt-engine-hang
[142.016590] Starting dynamic subtest: rcs0
[143.860010] Dynamic subtest rcs0: SUCCESS (1.845s)
[143.873773] Starting dynamic subtest: bcs0
[145.843451] Dynamic subtest bcs0: SUCCESS (1.982s)
[145.857683] Starting dynamic subtest: vcs0
[147.891055] Dynamic subtest vcs0: SUCCESS (2.046s)
[147.902423] Starting dynamic subtest: vcs1
[149.874804] Dynamic subtest vcs1: SUCCESS (1.982s)
[149.886830] Starting dynamic subtest: vecs0
[151.860156] Dynamic subtest vecs0: SUCCESS (1.984s)
[151.871144] Starting dynamic subtest: ccs0
[153.907430] Dynamic subtest ccs0: SUCCESS (2.046s)
[153.910235] Subtest gt-engine-hang: SUCCESS (11.892s)
[153.986360] [020/133] (864s left) syncobj_timeline (wait-all-snapshot)
[154.045985] Starting subtest: wait-all-snapshot
[154.127642] Subtest wait-all-snapshot: SUCCESS (0.082s)
[154.218168] [021/133] (864s left) gem_exec_reloc (basic-write-read)
[154.288521] Subtest basic-write-read: SKIP (0.000s)
[154.364166] [022/133] (864s left) sw_sync (alloc_merge_fence)
[154.399904] Starting subtest: alloc_merge_fence
[154.402089] Subtest alloc_merge_fence: SUCCESS (0.000s)
[154.457137] [023/133] (864s left) prime_vgem (basic-fence-read)
[154.520863] Starting subtest: basic-fence-read
[154.528832] Subtest basic-fence-read: SKIP (0.006s)
[154.636379] [024/133] (863s left) gem_pwrite (basic-self)
[154.693931] Subtest basic-self: SKIP (0.000s)
[154.748525] [025/133] (863s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[154.850489] Starting subtest: 4-tiled-addfb-size-offset-overflow
[154.852795] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[154.947717] [026/133] (863s left) gem_exec_schedule (noreorder-corked)
[155.126047] Starting subtest: noreorder-corked
[155.128571] Starting dynamic subtest: rcs0
[156.262695] Dynamic subtest rcs0: SUCCESS (1.137s)
[156.273972] Starting dynamic subtest: vcs0
[157.904832] Dynamic subtest vcs0: SUCCESS (1.639s)
[157.916036] Starting dynamic subtest: vcs1
[159.893903] Dynamic subtest vcs1: SUCCESS (1.988s)
[159.906736] Starting dynamic subtest: vecs0
[161.872073] Dynamic subtest vecs0: SUCCESS (1.977s)
[161.883338] Starting dynamic subtest: ccs0
[163.019928] Dynamic subtest ccs0: SUCCESS (1.149s)
[163.022565] Subtest noreorder-corked: SUCCESS (7.894s)
[163.205347] [027/133] (855s left) kms_invalid_mode (overflow-vrefresh)
[163.304956] Starting subtest: overflow-vrefresh
[163.307248] Starting dynamic subtest: pipe-A-eDP-1
[163.592160] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s)
[163.600790] Starting dynamic subtest: pipe-B-eDP-1
[163.603132] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[163.610921] Starting dynamic subtest: pipe-C-eDP-1
[163.613268] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[163.625213] Starting dynamic subtest: pipe-D-eDP-1
[163.627813] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[163.630297] Subtest overflow-vrefresh: SUCCESS (0.291s)
[164.468296] [028/133] (854s left) kms_cursor_crc (cursor-onscreen-128x128)
[164.692870] Starting subtest: cursor-onscreen-128x128
[164.695426] Starting dynamic subtest: pipe-A-eDP-1
[166.794532] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.095s)
[166.821749] Starting dynamic subtest: pipe-D-eDP-1
[169.549431] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.735s)
[169.551382] Subtest cursor-onscreen-128x128: SUCCESS (4.856s)
[170.354032] [029/133] (848s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[170.455530] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[170.459636] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[170.551676] [030/133] (848s left) gem_exec_fence (syncobj-timeline-repeat)
[171.094463] Starting subtest: syncobj-timeline-repeat
[171.325098] Subtest syncobj-timeline-repeat: SUCCESS (0.233s)
[172.959088] [031/133] (845s left) kms_color (ctm-signed)
[173.062970] Starting subtest: ctm-signed
[173.065011] Starting dynamic subtest: pipe-A-eDP-1
[175.155200] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.094s)
[175.166676] Starting dynamic subtest: pipe-B-eDP-1
[178.005708] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.846s)
[178.021816] Starting dynamic subtest: pipe-C-eDP-1
[180.658782] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.656s)
[180.668157] Starting dynamic subtest: pipe-D-eDP-1
[183.327691] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.666s)
[183.329994] Subtest ctm-signed: SUCCESS (10.264s)
[184.148145] [032/133] (834s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[184.244621] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[191.113752] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.873s)
[191.223904] [033/133] (827s left) kms_rotation_crc (bad-pixel-format)
[191.320064] Starting subtest: bad-pixel-format
[191.324267] Subtest bad-pixel-format: SKIP (0.001s)
[191.396781] [034/133] (827s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[191.517690] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[191.520089] Starting dynamic subtest: pipe-A-eDP-1
[191.539921] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[191.550262] Starting dynamic subtest: pipe-B-eDP-1
[191.570102] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[191.577761] Starting dynamic subtest: pipe-C-eDP-1
[191.596937] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[191.604515] Starting dynamic subtest: pipe-D-eDP-1
[191.623694] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[191.625576] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.004s)
[193.700345] [035/133] (825s left) gem_exec_balancer (invalid-bonds)
[193.765408] Starting subtest: invalid-bonds
[193.769836] Subtest invalid-bonds: SKIP (0.000s)
[194.085948] [036/133] (824s left) kms_plane (pixel-format-y-tiled-ccs-modifier)
[194.186096] Starting subtest: pixel-format-y-tiled-ccs-modifier
[194.190387] Subtest pixel-format-y-tiled-ccs-modifier: SKIP (0.000s)
[194.273852] [037/133] (824s left) gem_exec_schedule (wide)
[194.449861] Starting subtest: wide
[194.456495] Starting dynamic subtest: rcs0
[204.543602] Dynamic subtest rcs0: SUCCESS (10.095s)
[204.557721] Starting dynamic subtest: vcs0
[215.610310] Dynamic subtest vcs0: SUCCESS (11.066s)
[215.620439] Starting dynamic subtest: vcs1
[228.086445] Dynamic subtest vcs1: SUCCESS (12.475s)
[228.097194] Starting dynamic subtest: vecs0
[239.729636] Dynamic subtest vecs0: SUCCESS (11.642s)
[239.744367] Starting dynamic subtest: ccs0
[254.667378] Dynamic subtest ccs0: SUCCESS (14.936s)
[254.669966] Subtest wide: SUCCESS (60.218s)
[257.239775] [038/133] (761s left) kms_flip (2x-modeset-vs-vblank-race)
[257.330481] Starting subtest: 2x-modeset-vs-vblank-race
[257.342057] Subtest 2x-modeset-vs-vblank-race: SKIP (0.011s)
[257.421195] [039/133] (761s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[257.516103] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[257.520239] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[257.630964] [040/133] (761s left) i915_suspend (basic-s2idle-without-i915)
[257.667787] Starting subtest: basic-s2idle-without-i915
[277.534374] Subtest basic-s2idle-without-i915: SUCCESS (4.077s)
[277.672213] [041/133] (741s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[277.785122] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[287.081677] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.435s)
[287.204653] [042/133] (732s left) gem_close (many-handles-one-vma)
[287.279560] Starting subtest: many-handles-one-vma
[287.315769] Subtest many-handles-one-vma: SUCCESS (0.040s)
[287.414244] [043/133] (731s left) gem_fenced_exec_thrash (too-many-fences)
[287.475402] Subtest too-many-fences: SKIP (0.000s)
[287.534368] [044/133] (731s left) kms_getfb (getfb-handle-closed)
[287.628131] Starting subtest: getfb-handle-closed
[287.630441] Subtest getfb-handle-closed: SUCCESS (0.000s)
[287.726721] [045/133] (731s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[287.781853] Starting subtest: yf-tiled-ccs-to-x-tiled
[287.786304] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[287.962716] [046/133] (731s left) kms_psr (psr2-suspend)
[288.067977] Starting subtest: psr2-suspend
[288.070741] Starting dynamic subtest: eDP-1
[305.561927] Dynamic subtest eDP-1: SUCCESS (3.613s)
[305.564806] Subtest psr2-suspend: SUCCESS (3.614s)
[306.429777] [047/133] (712s left) kms_hdr (brightness-with-hdr)
[306.531933] Starting subtest: brightness-with-hdr
[306.539320] Subtest brightness-with-hdr: SKIP (0.000s)
[306.614436] [048/133] (712s left) i915_drm_fdinfo (busy-check-all)
[306.652158] Starting subtest: busy-check-all
[306.654577] Starting dynamic subtest: rcs0
[306.659779] Dynamic subtest rcs0: SKIP (0.005s)
[306.669554] Starting dynamic subtest: bcs0
[306.674607] Dynamic subtest bcs0: SKIP (0.000s)
[306.682829] Starting dynamic subtest: vcs0
[306.687874] Dynamic subtest vcs0: SKIP (0.000s)
[306.696041] Starting dynamic subtest: vcs1
[306.701178] Dynamic subtest vcs1: SKIP (0.000s)
[306.709328] Starting dynamic subtest: vecs0
[306.714635] Dynamic subtest vecs0: SKIP (0.000s)
[306.722903] Starting dynamic subtest: ccs0
[306.728046] Dynamic subtest ccs0: SKIP (0.000s)
[306.733054] Subtest busy-check-all: SKIP (0.009s)
[306.771558] [049/133] (712s left) gem_eio (in-flight-suspend)
[306.922926] Starting subtest: in-flight-suspend
[350.296062] Subtest in-flight-suspend: SUCCESS (13.682s)
[350.484152] [050/133] (669s left) kms_psr (fbc-pr-sprite-plane-onoff)
[350.595467] Starting subtest: fbc-pr-sprite-plane-onoff
[350.599913] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[350.668911] [051/133] (668s left) gem_softpin (evict-single-offset)
[350.722105] Starting subtest: evict-single-offset
[375.437932] Subtest evict-single-offset: SUCCESS (24.896s)
[375.528204] [052/133] (644s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[375.687036] Starting subtest: fbc-indfb-scaledprimary
[378.693538] Subtest fbc-indfb-scaledprimary: SUCCESS (3.013s)
[379.823772] [053/133] (639s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[379.927166] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[379.931859] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[380.044306] [054/133] (639s left) kms_psr (psr-primary-mmap-cpu)
[380.132748] Starting subtest: psr-primary-mmap-cpu
[380.134997] Starting dynamic subtest: eDP-1
[381.915859] Dynamic subtest eDP-1: SUCCESS (1.782s)
[381.918177] Subtest psr-primary-mmap-cpu: SUCCESS (1.783s)
[382.792645] [055/133] (636s left) kms_dsc (dsc-fractional-bpp)
[382.894721] Starting subtest: dsc-fractional-bpp
[382.908101] Subtest dsc-fractional-bpp: SKIP (0.000s)
[382.970112] [056/133] (636s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[383.068887] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[384.197851] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: FAIL (0.530s)
[384.240869] [057/133] (635s left) prime_vgem (busy)
[384.312454] Starting subtest: busy
[384.314820] Starting dynamic subtest: rcs0
[384.386671] Dynamic subtest rcs0: SUCCESS (0.074s)
[384.397165] Starting dynamic subtest: bcs0
[384.437177] Dynamic subtest bcs0: SUCCESS (0.050s)
[384.446062] Starting dynamic subtest: vcs0
[384.483428] Dynamic subtest vcs0: SUCCESS (0.045s)
[384.492215] Starting dynamic subtest: vcs1
[384.530005] Dynamic subtest vcs1: SUCCESS (0.046s)
[384.539087] Starting dynamic subtest: vecs0
[384.577382] Dynamic subtest vecs0: SUCCESS (0.047s)
[384.586392] Starting dynamic subtest: ccs0
[384.623794] Dynamic subtest ccs0: SUCCESS (0.046s)
[384.625613] Subtest busy: SUCCESS (0.312s)
[384.751607] [058/133] (635s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[384.807559] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[384.811239] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[385.016753] [059/133] (634s left) gem_ctx_bad_destroy (invalid-ctx)
[385.071466] Starting subtest: invalid-ctx
[385.073933] Subtest invalid-ctx: SUCCESS (0.000s)
[385.148253] [060/133] (634s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-render)
[385.248379] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-render
[389.419720] Subtest fbc-1p-offscreen-pri-shrfb-draw-render: SUCCESS (4.173s)
[390.592536] [061/133] (629s left) kms_addfb_basic (invalid-set-prop-any)
[390.649859] Starting subtest: invalid-set-prop-any
[390.652531] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[390.793553] [062/133] (629s left) kms_cursor_legacy (forked-move)
[390.915726] Starting subtest: forked-move
[390.917581] Starting dynamic subtest: pipe-A
[396.381511] Dynamic subtest pipe-A: SUCCESS (5.463s)
[396.394359] Starting dynamic subtest: pipe-B
[401.858470] Dynamic subtest pipe-B: SUCCESS (5.475s)
[401.869801] Starting dynamic subtest: pipe-C
[407.333559] Dynamic subtest pipe-C: SUCCESS (5.474s)
[407.344212] Starting dynamic subtest: pipe-D
[412.803853] Dynamic subtest pipe-D: SUCCESS (5.469s)
[412.814422] Starting dynamic subtest: all-pipes
[418.301079] Dynamic subtest all-pipes: SUCCESS (5.495s)
[418.303778] Subtest forked-move: SUCCESS (27.386s)
[418.449884] [063/133] (601s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[418.568046] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[418.572519] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[418.687181] [064/133] (601s left) gem_media_fill (media-fill)
[418.743034] Subtest media-fill: SKIP (0.000s)
[418.852624] [065/133] (601s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[418.914051] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[418.983771] [066/133] (601s left) sysfs_timeslice_duration (invalid)
[419.036166] Starting subtest: invalid
[419.038608] Starting dynamic subtest: vecs0
[419.041004] Dynamic subtest vecs0: SUCCESS (0.000s)
[419.050375] Starting dynamic subtest: ccs0
[419.052315] Dynamic subtest ccs0: SUCCESS (0.000s)
[419.060738] Starting dynamic subtest: vcs0
[419.062633] Dynamic subtest vcs0: SUCCESS (0.000s)
[419.070959] Starting dynamic subtest: bcs0
[419.072874] Dynamic subtest bcs0: SUCCESS (0.000s)
[419.081503] Starting dynamic subtest: rcs0
[419.083683] Dynamic subtest rcs0: SUCCESS (0.000s)
[419.092274] Starting dynamic subtest: vcs1
[419.094207] Dynamic subtest vcs1: SUCCESS (0.000s)
[419.096149] Subtest invalid: SUCCESS (0.005s)
[419.147824] [067/133] (601s left) syncobj_wait (wait-all-for-submit-complex)
[419.205971] Starting subtest: wait-all-for-submit-complex
[419.418220] Subtest wait-all-for-submit-complex: SUCCESS (0.213s)
[419.494800] [068/133] (600s left) gem_exec_capture (pi)
[419.570830] Starting subtest: pi
[419.573027] Starting dynamic subtest: rcs0
[423.520461] Dynamic subtest rcs0: SUCCESS (3.951s)
[423.532190] Starting dynamic subtest: bcs0
[427.391077] Dynamic subtest bcs0: SUCCESS (3.870s)
[427.403368] Starting dynamic subtest: vcs0
[431.318196] Dynamic subtest vcs0: SUCCESS (3.928s)
[431.330832] Starting dynamic subtest: vcs1
[435.207131] Dynamic subtest vcs1: SUCCESS (3.889s)
[435.219073] Starting dynamic subtest: vecs0
[439.052278] Dynamic subtest vecs0: SUCCESS (3.845s)
[439.062478] Starting dynamic subtest: ccs0
[442.934580] Dynamic subtest ccs0: SUCCESS (3.883s)
[442.937134] Subtest pi: SUCCESS (23.373s)
[443.017510] [069/133] (577s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[443.162977] Starting subtest: fbcpsr-stridechange
[449.381196] Subtest fbcpsr-stridechange: SUCCESS (6.221s)
[449.517274] [070/133] (570s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[449.566650] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[449.616580] [071/133] (570s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[449.710207] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[449.712508] Starting dynamic subtest: pipe-A
[449.938506] Dynamic subtest pipe-A: SUCCESS (0.229s)
[449.949934] Starting dynamic subtest: pipe-B
[451.277444] Dynamic subtest pipe-B: SUCCESS (1.337s)
[451.288842] Starting dynamic subtest: pipe-C
[452.632462] Dynamic subtest pipe-C: SUCCESS (1.354s)
[452.644244] Starting dynamic subtest: pipe-D
[453.961586] Dynamic subtest pipe-D: SUCCESS (1.327s)
[453.963755] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.252s)
[455.123804] [072/133] (565s left) gem_exec_schedule (submit-late-slice)
[455.215416] Starting subtest: submit-late-slice
[455.217690] Starting dynamic subtest: rcs0
[455.245870] Dynamic subtest rcs0: SUCCESS (0.033s)
[455.258161] Starting dynamic subtest: bcs0
[455.286251] Dynamic subtest bcs0: SUCCESS (0.040s)
[455.295995] Starting dynamic subtest: vcs0
[455.324198] Dynamic subtest vcs0: SUCCESS (0.037s)
[455.334198] Starting dynamic subtest: vcs1
[455.364881] Dynamic subtest vcs1: SUCCESS (0.040s)
[455.374508] Starting dynamic subtest: vecs0
[455.408064] Dynamic subtest vecs0: SUCCESS (0.042s)
[455.423046] Starting dynamic subtest: ccs0
[455.446582] Dynamic subtest ccs0: SUCCESS (0.037s)
[455.448871] Subtest submit-late-slice: SUCCESS (0.235s)
[456.481984] [073/133] (564s left) kms_cdclk (plane-scaling)
[456.582430] Starting subtest: plane-scaling
[456.584730] Starting dynamic subtest: pipe-A-eDP-1
[456.873185] Dynamic subtest pipe-A-eDP-1: SKIP (0.287s)
[456.883582] Starting dynamic subtest: pipe-B-eDP-1
[456.888296] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[456.897997] Starting dynamic subtest: pipe-C-eDP-1
[456.902793] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[456.912052] Starting dynamic subtest: pipe-D-eDP-1
[456.916380] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[456.920482] Subtest plane-scaling: SKIP (0.294s)
[457.658309] [074/133] (562s left) kms_vrr (flip-suspend)
[457.755409] Starting subtest: flip-suspend
[457.761692] Subtest flip-suspend: SKIP (0.000s)
[457.829132] [075/133] (562s left) kms_3d (basic)
[457.881187] Starting subtest: basic
[459.846309] Subtest basic: SUCCESS (1.968s)
[460.319723] [076/133] (560s left) fbdev (eof)
[460.375910] Starting subtest: eof
[460.378516] Subtest eof: SUCCESS (0.000s)
[460.446882] [077/133] (560s left) gem_mmap_offset (blt-coherency)
[460.511364] Starting subtest: blt-coherency
[460.516119] Subtest blt-coherency: SUCCESS (0.006s)
[460.641406] [078/133] (560s left) gem_exec_params (rel-constants-invalid)
[460.696902] Starting subtest: rel-constants-invalid
[460.699151] Subtest rel-constants-invalid: SUCCESS (0.000s)
[460.798812] [079/133] (560s left) api_intel_bb (blit-reloc-keep-cache)
[460.856215] Starting subtest: blit-reloc-keep-cache
[460.860720] Subtest blit-reloc-keep-cache: SKIP (0.000s)
[460.976689] [080/133] (559s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[461.036242] Starting subtest: etime-multi-wait-all-for-submit-submitted
[461.144790] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.108s)
[461.221085] [081/133] (559s left) kms_big_fb (x-tiled-64bpp-rotate-0)
[461.338004] Starting subtest: x-tiled-64bpp-rotate-0
[463.041072] Subtest x-tiled-64bpp-rotate-0: SUCCESS (1.702s)
[463.230634] [082/133] (557s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[463.290341] Starting subtest: etime-multi-wait-all-submitted-signaled
[463.393761] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.102s)
[463.487076] [083/133] (557s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[463.596561] Starting subtest: y-tiled-32bpp-rotate-90
[463.600590] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[463.691766] [084/133] (557s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[463.748857] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[463.813100] [085/133] (557s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[463.910676] Starting subtest: pr-overlay-plane-move-continuous-sf
[463.914727] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[463.980466] [086/133] (557s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[464.072892] Starting subtest: plane-upscale-20x20-with-modifiers
[464.075176] Starting dynamic subtest: pipe-A
[464.407204] Dynamic subtest pipe-A: SUCCESS (0.338s)
[464.418018] Starting dynamic subtest: pipe-B
[465.850128] Dynamic subtest pipe-B: SUCCESS (1.442s)
[465.861389] Starting dynamic subtest: pipe-C
[467.241948] Dynamic subtest pipe-C: SUCCESS (1.391s)
[467.251556] Starting dynamic subtest: pipe-D
[468.645961] Dynamic subtest pipe-D: SUCCESS (1.403s)
[468.648241] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.577s)
[469.794834] [087/133] (551s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[469.856711] Subtest untiled-to-tiled: SKIP (0.000s)
[469.934636] [088/133] (551s left) gem_ctx_param (set-priority-not-supported)
[469.987890] Starting subtest: set-priority-not-supported
[469.992346] Subtest set-priority-not-supported: SKIP (0.000s)
[470.061584] [089/133] (551s left) gen7_exec_parse (cmd-crossing-page)
[470.115746] Subtest cmd-crossing-page: SKIP (0.000s)
[470.190572] [090/133] (551s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[470.278636] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[470.283240] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[471.387404] [091/133] (549s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[471.469657] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[471.473799] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.000s)
[471.555709] [092/133] (549s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[471.649060] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[471.653046] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[471.742774] [093/133] (549s left) dumb_buffer (map-invalid-size)
[471.791259] Starting subtest: map-invalid-size
[471.793419] Subtest map-invalid-size: SUCCESS (0.000s)
[471.876877] [094/133] (549s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[471.976675] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[479.156410] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.184s)
[479.297872] [095/133] (542s left) kms_flip (2x-flip-vs-panning)
[479.404646] Starting subtest: 2x-flip-vs-panning
[479.413221] Subtest 2x-flip-vs-panning: SKIP (0.010s)
[479.505220] [096/133] (542s left) gem_ctx_persistence (engines-mixed)
[479.560819] Starting subtest: engines-mixed
[479.563200] Starting dynamic subtest: rcs0
[479.640187] Dynamic subtest rcs0: SUCCESS (0.079s)
[479.653009] Starting dynamic subtest: bcs0
[479.685953] Dynamic subtest bcs0: SUCCESS (0.044s)
[479.696767] Starting dynamic subtest: vcs0
[479.744141] Dynamic subtest vcs0: SUCCESS (0.056s)
[479.755950] Starting dynamic subtest: vcs1
[479.785707] Dynamic subtest vcs1: SUCCESS (0.039s)
[479.796303] Starting dynamic subtest: vecs0
[479.826889] Dynamic subtest vecs0: SUCCESS (0.040s)
[479.837803] Starting dynamic subtest: ccs0
[479.885353] Dynamic subtest ccs0: SUCCESS (0.057s)
[479.887900] Subtest engines-mixed: SUCCESS (0.326s)
[479.964797] [097/133] (541s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[480.068732] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[480.073113] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.000s)
[480.138518] [098/133] (541s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[480.230914] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[480.234707] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[480.327239] [099/133] (541s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[480.438138] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[480.441728] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[480.537652] [100/133] (541s left) kms_content_protection (dp-mst-type-1)
[480.672094] Starting subtest: dp-mst-type-1
[480.675966] Subtest dp-mst-type-1: SKIP (0.000s)
[480.791221] [101/133] (540s left) kms_flip (2x-flip-vs-panning-vs-hang)
[480.887846] Starting subtest: 2x-flip-vs-panning-vs-hang
[480.899027] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.010s)
[481.006245] [102/133] (540s left) kms_lease (lease-revoke)
[481.097501] Starting subtest: lease-revoke
[481.099440] Starting dynamic subtest: pipe-A-eDP-1
[481.127905] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.030s)
[481.138905] Starting dynamic subtest: pipe-B-eDP-1
[481.157550] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.029s)
[481.166632] Starting dynamic subtest: pipe-C-eDP-1
[481.184836] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.027s)
[481.194276] Starting dynamic subtest: pipe-D-eDP-1
[481.217559] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.029s)
[481.219435] Subtest lease-revoke: SUCCESS (0.121s)
[481.360531] [103/133] (540s left) kms_setmode (invalid-clone-single-crtc)
[481.418189] Starting subtest: invalid-clone-single-crtc
[481.423557] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[481.513264] [104/133] (540s left) gem_wait (write-wait)
[481.585786] Starting subtest: write-wait
[481.587952] Starting dynamic subtest: all-engines
[482.690300] Dynamic subtest all-engines: SUCCESS (1.103s)
[482.711378] Starting dynamic subtest: rcs0
[483.751654] Dynamic subtest rcs0: SUCCESS (1.059s)
[483.768398] Starting dynamic subtest: bcs0
[484.809997] Dynamic subtest bcs0: SUCCESS (1.057s)
[484.827103] Starting dynamic subtest: vcs0
[485.863678] Dynamic subtest vcs0: SUCCESS (1.052s)
[485.881282] Starting dynamic subtest: vcs1
[486.916440] Dynamic subtest vcs1: SUCCESS (1.051s)
[486.933501] Starting dynamic subtest: vecs0
[487.969487] Dynamic subtest vecs0: SUCCESS (1.051s)
[487.986400] Starting dynamic subtest: ccs0
[489.025398] Dynamic subtest ccs0: SUCCESS (1.054s)
[489.028161] Subtest write-wait: SUCCESS (7.441s)
[489.232028] [105/133] (532s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[490.777410] Starting subtest: modeset-non-lpsp-stress-no-wait
[490.828870] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.054s)
[491.480377] [106/133] (530s left) kms_addfb_basic (unused-offsets)
[491.544983] Starting subtest: unused-offsets
[491.546975] Subtest unused-offsets: SUCCESS (0.000s)
[491.675838] [107/133] (530s left) kms_cursor_crc (cursor-random-512x170)
[491.982540] Starting subtest: cursor-random-512x170
[491.987212] Subtest cursor-random-512x170: SKIP (0.001s)
[492.129899] [108/133] (529s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs)
[492.215565] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs
[492.217876] Starting dynamic subtest: pipe-A-eDP-1
[492.240463] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[492.250900] Starting dynamic subtest: pipe-B-eDP-1
[492.272652] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[492.282066] Starting dynamic subtest: pipe-C-eDP-1
[492.303452] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[492.312925] Starting dynamic subtest: pipe-D-eDP-1
[492.334550] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[492.338514] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.009s)
[494.476134] [109/133] (527s left) i915_pm_rps (basic-api)
[494.534903] Starting subtest: basic-api
[494.539610] Subtest basic-api: SKIP (0.001s)
[494.648859] [110/133] (527s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[494.744384] Starting subtest: coverage-vs-premult-vs-constant
[495.030221] Starting dynamic subtest: pipe-A-eDP-1
[495.605960] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.575s)
[495.616771] Starting dynamic subtest: pipe-D-eDP-1
[496.967831] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.358s)
[496.969994] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.224s)
[497.781259] [111/133] (524s left) syncobj_timeline (multi-wait-submitted-signaled)
[497.830432] Starting subtest: multi-wait-submitted-signaled
[497.832696] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[497.925773] [112/133] (524s left) kms_cursor_crc (cursor-sliding-32x10)
[498.087389] Starting subtest: cursor-sliding-32x10
[498.133628] Subtest cursor-sliding-32x10: SKIP (0.041s)
[498.426713] [113/133] (523s left) kms_properties (connector-properties-legacy)
[498.516405] Starting subtest: connector-properties-legacy
[498.518264] Starting dynamic subtest: pipe-A-eDP-1
[506.643664] Dynamic subtest pipe-A-eDP-1: SUCCESS (8.128s)
[506.656734] Starting dynamic subtest: pipe-None-DP-1
[506.660517] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[506.669133] Starting dynamic subtest: pipe-None-HDMI-A-1
[506.673410] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[506.682110] Starting dynamic subtest: pipe-None-DP-2
[506.687096] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[506.699977] Starting dynamic subtest: pipe-None-HDMI-A-2
[506.704391] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[506.713695] Starting dynamic subtest: pipe-None-DP-3
[506.717551] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[506.726296] Starting dynamic subtest: pipe-None-DP-4
[506.730116] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[506.731949] Subtest connector-properties-legacy: SUCCESS (8.139s)
[507.480223] [114/133] (514s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[507.536355] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[507.538559] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[507.641767] [115/133] (514s left) api_intel_bb (reset-flags)
[507.700054] Starting subtest: reset-flags
[507.704964] Subtest reset-flags: SUCCESS (0.007s)
[507.831816] [116/133] (514s left) gem_exec_create (madvise)
[507.891290] Starting subtest: madvise
[507.893565] Starting dynamic subtest: smem
[529.480227] Dynamic subtest smem: SUCCESS (21.591s)
[529.482766] Subtest madvise: SUCCESS (21.592s)
[530.705750] [117/133] (491s left) gem_eio (hibernate)
[530.952803] Starting subtest: hibernate
[545.634000] Subtest hibernate: SUCCESS (14.685s)
[552.824169] [118/133] (476s left) kms_atomic (atomic-plane-damage)
[552.974290] Starting subtest: atomic-plane-damage
[553.056036] Starting dynamic subtest: pipe-A-eDP-1
[553.583706] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.530s)
[553.586209] Subtest atomic-plane-damage: SUCCESS (0.612s)
[554.475743] [119/133] (475s left) kms_psr (fbc-psr-basic)
[554.571770] Starting subtest: fbc-psr-basic
[554.574059] Starting dynamic subtest: eDP-1
[554.578577] Dynamic subtest eDP-1: SKIP (0.000s)
[554.583161] Subtest fbc-psr-basic: SKIP (0.001s)
[554.661621] [120/133] (474s left) kms_addfb_basic (bo-too-small)
[554.767264] Starting subtest: bo-too-small
[554.769558] Subtest bo-too-small: SUCCESS (0.000s)
[554.873701] [121/133] (474s left) gem_mmap_gtt (basic-read)
[554.930532] Subtest basic-read: SKIP (0.000s)
[554.998057] [122/133] (474s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[555.111501] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[561.774792] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (6.665s)
[561.886755] [123/133] (467s left) gem_eio (wait-wedge-1us)
[562.137375] Starting subtest: wait-wedge-1us
[563.480449] Subtest wait-wedge-1us: SUCCESS (1.345s)
[563.615651] [124/133] (466s left) perf_pmu (interrupts)
[563.660027] Starting subtest: interrupts
[564.738944] Subtest interrupts: SUCCESS (1.081s)
[564.854734] [125/133] (464s left) perf (buffer-fill)
[565.020819] Starting subtest: buffer-fill
[565.023123] Starting dynamic subtest: 0-rcs0
[567.288737] Dynamic subtest 0-rcs0: SUCCESS (2.268s)
[567.301361] Starting dynamic subtest: 1-vcs0
[571.676915] Dynamic subtest 1-vcs0: SUCCESS (4.387s)
[571.679314] Subtest buffer-fill: SUCCESS (6.658s)
[571.729034] [126/133] (458s left) gem_ctx_persistence (heartbeat-many)
[571.795362] Starting subtest: heartbeat-many
[571.799887] Subtest heartbeat-many: SKIP (0.000s)
[571.900928] [127/133] (457s left) template (b)
[571.952091] Starting subtest: B
[571.954135] Subtest B: SUCCESS (0.000s)
[572.067207] [128/133] (457s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[572.158136] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb
[572.160476] Starting dynamic subtest: pipe-A-eDP-1
[578.639447] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.484s)
[578.650273] Starting dynamic subtest: pipe-B-eDP-1
[585.730446] Dynamic subtest pipe-B-eDP-1: SUCCESS (7.092s)
[585.732897] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.580s)
[586.559500] [129/133] (443s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[586.657954] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[586.662431] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[586.746316] [130/133] (443s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[586.842042] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[586.846175] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[586.928304] [131/133] (443s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[587.017661] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[587.019570] Starting dynamic subtest: pipe-A-eDP-1
[619.395370] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.854s)
[619.406449] Starting dynamic subtest: pipe-B-eDP-1
[652.339473] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.647s)
[652.350676] Starting dynamic subtest: pipe-C-eDP-1
[685.307253] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.659s)
[685.318872] Starting dynamic subtest: pipe-D-eDP-1
[718.308134] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.698s)
[718.310586] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (13.862s)
[719.454719] [132/133] (310s left) kms_selftest (drm_dp_mst_helper)
[719.505657] Starting subtest: drm_dp_mst_helper
[719.521950] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[719.616105] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.097s)
[719.627506] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[719.712747] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.098s)
[719.723243] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[719.827896] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.118s)
[719.830279] Subtest drm_dp_mst_helper: SUCCESS (0.328s)
[719.988669] [133/133] (310s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k)
[720.379385] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s)
[721.164928] Closing watchdogs
results: parsing output: 0/ for test: perf_pmu
results: parsing output: 1/ for test: gem_exec_schedule
results: parsing output: 2/ for test: gem_eio
results: parsing output: 3/ for test: gem_ctx_engines
results: parsing output: 4/ for test: gem_exec_flush
results: parsing output: 5/ for test: gem_ctx_shared
results: parsing output: 6/ for test: kms_flip
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_psr
results: parsing output: 9/ for test: kms_chamelium_hpd
results: parsing output: 10/ for test: kms_vblank
results: parsing output: 11/ for test: kms_cursor_legacy
results: parsing output: 12/ for test: kms_plane
results: parsing output: 13/ for test: kms_big_fb
results: parsing output: 14/ for test: kms_pm_rpm
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: gem_exec_reloc
results: parsing output: 17/ for test: kms_psr2_sf
results: parsing output: 18/ for test: i915_hangman
results: parsing output: 19/ for test: syncobj_timeline
results: parsing output: 20/ for test: gem_exec_reloc
results: parsing output: 21/ for test: sw_sync
results: parsing output: 22/ for test: prime_vgem
results: parsing output: 23/ for test: gem_pwrite
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: gem_exec_schedule
results: parsing output: 26/ for test: kms_invalid_mode
results: parsing output: 27/ for test: kms_cursor_crc
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: gem_exec_fence
results: parsing output: 30/ for test: kms_color
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_rotation_crc
results: parsing output: 33/ for test: kms_ccs
results: parsing output: 34/ for test: gem_exec_balancer
results: parsing output: 35/ for test: kms_plane
results: parsing output: 36/ for test: gem_exec_schedule
results: parsing output: 37/ for test: kms_flip
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: i915_suspend
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: gem_close
results: parsing output: 42/ for test: gem_fenced_exec_thrash
results: parsing output: 43/ for test: kms_getfb
results: parsing output: 44/ for test: gem_render_copy
results: parsing output: 45/ for test: kms_psr
results: parsing output: 46/ for test: kms_hdr
results: parsing output: 47/ for test: i915_drm_fdinfo
results: parsing output: 48/ for test: gem_eio
results: parsing output: 49/ for test: kms_psr
results: parsing output: 50/ for test: gem_softpin
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_psr
results: parsing output: 54/ for test: kms_dsc
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: prime_vgem
results: parsing output: 57/ for test: gem_render_copy
results: parsing output: 58/ for test: gem_ctx_bad_destroy
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_addfb_basic
results: parsing output: 61/ for test: kms_cursor_legacy
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_media_fill
results: parsing output: 64/ for test: gem_fenced_exec_thrash
results: parsing output: 65/ for test: sysfs_timeslice_duration
results: parsing output: 66/ for test: syncobj_wait
results: parsing output: 67/ for test: gem_exec_capture
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: gem_lmem_swapping
results: parsing output: 70/ for test: kms_plane_scaling
results: parsing output: 71/ for test: gem_exec_schedule
results: parsing output: 72/ for test: kms_cdclk
results: parsing output: 73/ for test: kms_vrr
results: parsing output: 74/ for test: kms_3d
results: parsing output: 75/ for test: fbdev
results: parsing output: 76/ for test: gem_mmap_offset
results: parsing output: 77/ for test: gem_exec_params
results: parsing output: 78/ for test: api_intel_bb
results: parsing output: 79/ for test: syncobj_timeline
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: syncobj_timeline
results: parsing output: 82/ for test: kms_big_fb
results: parsing output: 83/ for test: kms_pipe_b_c_ivb
results: parsing output: 84/ for test: kms_psr2_sf
results: parsing output: 85/ for test: kms_plane_scaling
results: parsing output: 86/ for test: gem_set_tiling_vs_blt
results: parsing output: 87/ for test: gem_ctx_param
results: parsing output: 88/ for test: gen7_exec_parse
results: parsing output: 89/ for test: kms_ccs
results: parsing output: 90/ for test: kms_flip_scaled_crc
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: dumb_buffer
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_flip
results: parsing output: 95/ for test: gem_ctx_persistence
results: parsing output: 96/ for test: kms_flip_scaled_crc
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: kms_content_protection
results: parsing output: 100/ for test: kms_flip
results: parsing output: 101/ for test: kms_lease
results: parsing output: 102/ for test: kms_setmode
results: parsing output: 103/ for test: gem_wait
results: parsing output: 104/ for test: kms_pm_rpm
results: parsing output: 105/ for test: kms_addfb_basic
results: parsing output: 106/ for test: kms_cursor_crc
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: i915_pm_rps
results: parsing output: 109/ for test: kms_plane_alpha_blend
results: parsing output: 110/ for test: syncobj_timeline
results: parsing output: 111/ for test: kms_cursor_crc
results: parsing output: 112/ for test: kms_properties
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: api_intel_bb
results: parsing output: 115/ for test: gem_exec_create
results: parsing output: 116/ for test: gem_eio
results: parsing output: 117/ for test: kms_atomic
results: parsing output: 118/ for test: kms_psr
results: parsing output: 119/ for test: kms_addfb_basic
results: parsing output: 120/ for test: gem_mmap_gtt
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: gem_eio
results: parsing output: 123/ for test: perf_pmu
results: parsing output: 124/ for test: perf
results: parsing output: 125/ for test: gem_ctx_persistence
results: parsing output: 126/ for test: template
results: parsing output: 127/ for test: kms_psr2_sf
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_ccs
results: parsing output: 131/ for test: kms_selftest
results: parsing output: 132/ for test: kms_chamelium_edid
Done.