[55.769463] Initializing watchdogs
[55.769550]   /dev/watchdog0
[55.783899] [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]
[55.788511] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[55.790820] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[55.793695] [001/131] (960s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[55.918056] Starting subtest: plane-downscale-factor-0-5-with-rotation
[55.920462] Starting dynamic subtest: pipe-A
[55.929786] Dynamic subtest pipe-A: SKIP (0.007s)
[55.936508] Starting dynamic subtest: pipe-B
[55.953743] Dynamic subtest pipe-B: SKIP (0.023s)
[55.961126] Starting dynamic subtest: pipe-C
[55.975702] Dynamic subtest pipe-C: SKIP (0.022s)
[55.983805] Starting dynamic subtest: pipe-D
[55.997727] Dynamic subtest pipe-D: SKIP (0.022s)
[56.001936] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.074s)
[56.085323] [002/131] (960s left) gem_exec_reloc (basic-gtt-cpu)
[56.157155] Subtest basic-gtt-cpu: SKIP (0.000s)
[56.235337] [003/131] (960s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[56.353253] Starting subtest: cursorA-vs-flipA-toggle
[67.523913] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.176s)
[68.397319] [004/131] (948s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[68.455678] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[68.560126] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.102s)
[68.631909] [005/131] (947s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[68.728063] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[68.730420] Starting dynamic subtest: pipe-A-eDP-1
[68.751463] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[68.759094] Starting dynamic subtest: pipe-B-eDP-1
[68.778933] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[68.786097] Starting dynamic subtest: pipe-C-eDP-1
[68.806304] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[68.813912] Starting dynamic subtest: pipe-D-eDP-1
[68.833623] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[68.835902] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.003s)
[70.850684] [006/131] (945s left) gem_ctx_shared (q-smoketest)
[70.915647] Starting subtest: Q-smoketest
[70.918068] Starting dynamic subtest: rcs0
[76.483092] Dynamic subtest rcs0: SUCCESS (5.519s)
[76.491921] Starting dynamic subtest: bcs0
[81.970309] Dynamic subtest bcs0: SUCCESS (5.494s)
[81.977130] Starting dynamic subtest: vcs0
[87.450539] Dynamic subtest vcs0: SUCCESS (5.476s)
[87.462657] Starting dynamic subtest: vcs1
[92.928244] Dynamic subtest vcs1: SUCCESS (5.481s)
[92.935332] Starting dynamic subtest: vecs0
[98.412690] Dynamic subtest vecs0: SUCCESS (5.483s)
[98.421655] Starting dynamic subtest: ccs0
[103.917530] Dynamic subtest ccs0: SUCCESS (5.504s)
[103.919571] Subtest Q-smoketest: SUCCESS (32.959s)
[104.055752] [007/131] (912s left) kms_addfb_basic (too-high)
[104.159062] Starting subtest: too-high
[104.161450] Subtest too-high: SUCCESS (0.000s)
[104.278417] [008/131] (912s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[104.392679] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[104.397205] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[104.507444] [009/131] (912s left) prime_busy (before-wait)
[104.574043] Starting subtest: before-wait
[104.578962] Starting dynamic subtest: rcs0
[104.602366] Dynamic subtest rcs0: SUCCESS (0.025s)
[104.611720] Starting dynamic subtest: bcs0
[104.669841] Dynamic subtest bcs0: SUCCESS (0.067s)
[104.678959] Starting dynamic subtest: vcs0
[104.712115] Dynamic subtest vcs0: SUCCESS (0.042s)
[104.720621] Starting dynamic subtest: vcs1
[104.755365] Dynamic subtest vcs1: SUCCESS (0.043s)
[104.763935] Starting dynamic subtest: vecs0
[104.795099] Dynamic subtest vecs0: SUCCESS (0.040s)
[104.803285] Starting dynamic subtest: ccs0
[104.835872] Dynamic subtest ccs0: SUCCESS (0.040s)
[104.942934] Subtest before-wait: SUCCESS (0.367s)
[105.016122] [010/131] (911s left) drm_read (empty-block)
[105.172678] Starting subtest: empty-block
[106.174195] Subtest empty-block: SUCCESS (1.001s)
[106.290094] [011/131] (910s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[111.283128] Starting subtest: psr2-cursor-plane-move-continuous-sf
[111.285548] Starting dynamic subtest: pipe-A-eDP-1
[122.379532] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.094s)
[122.387270] Starting dynamic subtest: pipe-B-eDP-1
[133.397989] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.018s)
[133.400539] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (22.116s)
[134.187225] [012/131] (882s left) gem_exec_balancer (full-pulse)
[134.254545] Starting subtest: full-pulse
[138.862833] Subtest full-pulse: SUCCESS (4.607s)
[139.199488] [013/131] (877s left) gem_exec_schedule (preempt-queue)
[139.278833] Subtest preempt-queue: SKIP (0.000s)
[139.561277] [014/131] (877s left) gem_busy (close-race)
[139.616756] Starting subtest: close-race
[162.900308] Subtest close-race: SUCCESS (23.281s)
[163.296593] [FACT gem_busy (close-race)] new: kernel.kmod_is_loaded.vgem: true
[163.300542] [015/131] (853s left) kms_selftest (drm_dp_mst_helper)
[163.371022] Starting subtest: drm_dp_mst_helper
[163.437581] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[163.582614] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.147s)
[163.592578] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[163.719236] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.135s)
[163.728665] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[163.861103] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.142s)
[163.863083] Subtest drm_dp_mst_helper: SUCCESS (0.489s)
[164.043701] [016/131] (852s left) gem_exec_basic (basic)
[164.104252] Starting subtest: basic
[164.106758] Starting dynamic subtest: rcs0-smem
[164.111681] Dynamic subtest rcs0-smem: SUCCESS (0.006s)
[164.122642] Starting dynamic subtest: bcs0-smem
[164.125026] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[164.133060] Starting dynamic subtest: vcs0-smem
[164.135025] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[164.142746] Starting dynamic subtest: vcs1-smem
[164.144748] Dynamic subtest vcs1-smem: SUCCESS (0.002s)
[164.152215] Starting dynamic subtest: vecs0-smem
[164.154139] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[164.161544] Starting dynamic subtest: ccs0-smem
[164.163567] Dynamic subtest ccs0-smem: SUCCESS (0.003s)
[164.165561] Subtest basic: SUCCESS (0.018s)
[165.945505] [017/131] (850s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[166.042087] Starting subtest: primary-yf-tiled-reflect-x-270
[166.046807] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s)
[166.114116] [018/131] (850s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[166.165698] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[166.168084] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[166.286203] [019/131] (850s left) kms_psr (psr2-primary-mmap-cpu)
[166.373565] Starting subtest: psr2-primary-mmap-cpu
[166.375880] Starting dynamic subtest: eDP-1
[168.168035] Dynamic subtest eDP-1: SUCCESS (1.794s)
[168.170526] Subtest psr2-primary-mmap-cpu: SUCCESS (1.794s)
[169.049555] [020/131] (848s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[169.150029] Starting subtest: 4-tiled-32bpp-rotate-180
[170.805261] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.656s)
[171.028060] [021/131] (846s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[171.137867] Starting subtest: extended-modeset-hang-newfb-with-reset
[171.140337] Starting dynamic subtest: pipe-A
[184.961553] Dynamic subtest pipe-A: SUCCESS (13.820s)
[184.971667] Starting dynamic subtest: pipe-D
[200.837081] Dynamic subtest pipe-D: SUCCESS (15.873s)
[200.839559] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (29.698s)
[201.626494] [022/131] (815s left) gem_busy (semaphore)
[201.819705] Subtest semaphore: SKIP (0.000s)
[202.067877] [023/131] (815s left) perf (missing-sample-flags)
[202.200608] Starting subtest: missing-sample-flags
[202.202540] Subtest missing-sample-flags: SUCCESS (0.000s)
[202.241624] [024/131] (814s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[202.346621] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[206.298985] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.956s)
[207.425230] [025/131] (809s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[207.546400] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[208.949650] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.403s)
[209.758807] [026/131] (807s left) kms_color (ctm-0-50)
[209.850992] Starting subtest: ctm-0-50
[209.853419] Starting dynamic subtest: pipe-A-eDP-1
[213.280927] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.428s)
[213.289929] Starting dynamic subtest: pipe-B-eDP-1
[217.401284] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.118s)
[217.410304] Starting dynamic subtest: pipe-C-eDP-1
[221.344993] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.946s)
[221.354528] Starting dynamic subtest: pipe-D-eDP-1
[225.415565] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.067s)
[225.417709] Subtest ctm-0-50: SUCCESS (15.561s)
[226.246731] [027/131] (791s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[226.307548] Starting subtest: invalid-multi-wait-unsubmitted
[226.309766] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[226.429148] [028/131] (790s left) kms_getfb (getfb-handle-closed)
[226.530127] Starting subtest: getfb-handle-closed
[226.532433] Subtest getfb-handle-closed: SUCCESS (0.000s)
[226.636320] [029/131] (790s left) perf_pmu (render-node-busy)
[226.721184] Starting subtest: render-node-busy
[226.723792] Starting dynamic subtest: rcs0
[227.331533] Dynamic subtest rcs0: SUCCESS (0.610s)
[227.343159] Starting dynamic subtest: bcs0
[227.897149] Dynamic subtest bcs0: SUCCESS (0.564s)
[227.908798] Starting dynamic subtest: vcs0
[229.908210] Dynamic subtest vcs0: SUCCESS (2.008s)
[229.920419] Starting dynamic subtest: vcs1
[231.892369] Dynamic subtest vcs1: SUCCESS (1.982s)
[231.904265] Starting dynamic subtest: vecs0
[233.940682] Dynamic subtest vecs0: SUCCESS (2.047s)
[233.952196] Starting dynamic subtest: ccs0
[234.503351] Dynamic subtest ccs0: SUCCESS (0.563s)
[234.505897] Subtest render-node-busy: SUCCESS (7.782s)
[234.579090] [030/131] (782s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[234.674082] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[234.678283] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[234.792718] [031/131] (782s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[234.896325] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[234.898643] Starting dynamic subtest: pipe-A-eDP-1
[234.968480] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.071s)
[235.269526] Starting dynamic subtest: pipe-B-eDP-1
[236.046885] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.786s)
[236.325057] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.426s)
[237.192080] [032/131] (780s left) kms_addfb_basic (bad-pitch-1024)
[237.239799] Starting subtest: bad-pitch-1024
[237.241970] Subtest bad-pitch-1024: SUCCESS (0.000s)
[237.389811] [033/131] (780s left) prime_mmap (test_aperture_limit)
[237.455265] Starting subtest: test_aperture_limit
[237.457237] Starting dynamic subtest: test_aperture_limit-smem
[237.464242] Dynamic subtest test_aperture_limit-smem: SKIP (0.008s)
[237.468784] Subtest test_aperture_limit: SKIP (0.008s)
[237.571307] [034/131] (780s left) kms_cursor_crc (cursor-random-128x128)
[237.779993] Starting subtest: cursor-random-128x128
[237.785071] Starting dynamic subtest: pipe-A-eDP-1
[241.639933] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.856s)
[241.669477] Starting dynamic subtest: pipe-D-eDP-1
[245.995396] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.334s)
[245.997777] Subtest cursor-random-128x128: SUCCESS (8.214s)
[246.852816] [035/131] (770s left) gem_gpgpu_fill (offset-16x16)
[246.904715] Starting subtest: offset-16x16
[246.912079] Subtest offset-16x16: SUCCESS (0.008s)
[247.030405] [036/131] (770s left) kms_flip (flip-vs-suspend-interruptible)
[247.139202] Starting subtest: flip-vs-suspend-interruptible
[247.141505] Starting dynamic subtest: A-eDP1
[296.799374] Dynamic subtest A-eDP1: SUCCESS (4.552s)
[296.810210] Starting dynamic subtest: B-eDP1
[345.778318] Dynamic subtest B-eDP1: SUCCESS (4.295s)
[345.788792] Starting dynamic subtest: C-eDP1
[394.775224] Dynamic subtest C-eDP1: SUCCESS (4.331s)
[394.786206] Starting dynamic subtest: D-eDP1
[443.783277] Dynamic subtest D-eDP1: SUCCESS (4.331s)
[443.785654] Subtest flip-vs-suspend-interruptible: SUCCESS (17.517s)
[445.005957] [037/131] (572s left) intel_sysfs_debugfs (i915-sysfs-read-all-entries)
[445.081357] Starting subtest: i915-sysfs-read-all-entries
[445.286128] Subtest i915-sysfs-read-all-entries: SUCCESS (0.204s)
[445.461341] [038/131] (572s left) kms_vblank (wait-busy)
[445.568316] Starting subtest: wait-busy
[445.570891] Starting dynamic subtest: pipe-A-eDP-1
[447.455230] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.885s)
[447.471603] Starting dynamic subtest: pipe-D-eDP-1
[450.038874] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.583s)
[450.041598] Subtest wait-busy: SUCCESS (4.472s)
[450.833673] [039/131] (567s left) kms_pm_rpm (modeset-pc8-residency-stress)
[452.397047] Starting subtest: modeset-pc8-residency-stress
[452.402181] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[453.175930] [040/131] (564s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[453.271485] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[459.693745] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.426s)
[459.815670] [041/131] (558s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[459.891511] Starting subtest: yf-tiled-ccs-to-yf-tiled
[459.897201] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[460.076677] [042/131] (557s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-25)
[460.174318] Starting subtest: planes-upscale-20x20-downscale-factor-0-25
[460.177157] Starting dynamic subtest: pipe-A
[460.193617] Dynamic subtest pipe-A: SKIP (0.013s)
[460.204561] Starting dynamic subtest: pipe-B
[460.217739] Dynamic subtest pipe-B: SKIP (0.024s)
[460.228124] Starting dynamic subtest: pipe-C
[460.241693] Dynamic subtest pipe-C: SKIP (0.024s)
[460.252166] Starting dynamic subtest: pipe-D
[460.264940] Dynamic subtest pipe-D: SKIP (0.024s)
[460.268835] Subtest planes-upscale-20x20-downscale-factor-0-25: SKIP (0.086s)
[460.363633] [043/131] (557s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[460.471496] Starting subtest: x-tiled-32bpp-rotate-0
[462.271835] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.801s)
[462.571103] [044/131] (555s left) gem_exec_fence (syncobj-timeline-signal)
[463.113641] Starting subtest: syncobj-timeline-signal
[463.122563] Subtest syncobj-timeline-signal: SUCCESS (0.010s)
[464.098796] [045/131] (553s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[464.194179] Starting subtest: fbcpsr-slowdraw
[489.218077] Subtest fbcpsr-slowdraw: SUCCESS (25.047s)
[489.398787] [046/131] (528s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[489.512086] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[489.516863] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[489.616149] [047/131] (528s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[489.672952] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[489.674932] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[489.762256] [048/131] (528s left) gem_exec_schedule (u-independent)
[489.833960] Starting subtest: u-independent
[489.836363] Starting dynamic subtest: rcs0
[491.010961] Dynamic subtest rcs0: SUCCESS (1.186s)
[491.025376] Starting dynamic subtest: vcs0
[493.038849] Dynamic subtest vcs0: SUCCESS (2.027s)
[493.053213] Starting dynamic subtest: vcs1
[495.085694] Dynamic subtest vcs1: SUCCESS (2.046s)
[495.097314] Starting dynamic subtest: vecs0
[497.038576] Dynamic subtest vecs0: SUCCESS (1.952s)
[497.051846] Starting dynamic subtest: ccs0
[499.009420] Dynamic subtest ccs0: SUCCESS (1.971s)
[499.012418] Subtest u-independent: SUCCESS (9.191s)
[499.316422] [049/131] (518s left) kms_psr (pr-cursor-plane-onoff)
[499.417079] Starting subtest: pr-cursor-plane-onoff
[499.421600] Subtest pr-cursor-plane-onoff: SKIP (0.000s)
[499.492389] [050/131] (518s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[499.587099] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[499.592263] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[499.689938] [051/131] (518s left) gen9_exec_parse (basic-rejected-ctx-param)
[499.744442] Subtest basic-rejected-ctx-param: SKIP (0.000s)
[499.822674] [052/131] (518s left) kms_cursor_crc (async-cursor-crc-framebuffer-change)
[499.940859] Starting subtest: async-cursor-crc-framebuffer-change
[499.943151] Starting dynamic subtest: pipe-A-eDP-1
[500.514366] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.568s)
[500.525882] Starting dynamic subtest: pipe-D-eDP-1
[501.721107] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.209s)
[501.723868] Subtest async-cursor-crc-framebuffer-change: SUCCESS (1.779s)
[502.550410] [053/131] (515s left) kms_flip (plain-flip-fb-recreate-interruptible)
[502.659051] Starting subtest: plain-flip-fb-recreate-interruptible
[502.661581] Starting dynamic subtest: A-eDP1
[511.540385] Dynamic subtest A-eDP1: SUCCESS (8.886s)
[511.553973] Starting dynamic subtest: B-eDP1
[520.462899] Dynamic subtest B-eDP1: SUCCESS (8.923s)
[520.474416] Starting dynamic subtest: C-eDP1
[529.270062] Dynamic subtest C-eDP1: SUCCESS (8.810s)
[529.281988] Starting dynamic subtest: D-eDP1
[538.102234] Dynamic subtest D-eDP1: SUCCESS (8.834s)
[538.104279] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.464s)
[539.266829] [054/131] (479s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[539.359348] Starting subtest: fbc-dirtyfb-ioctl
[539.361859] Starting dynamic subtest: A-eDP-1
[541.972109] Dynamic subtest A-eDP-1: SUCCESS (2.611s)
[541.974852] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.613s)
[542.815859] [055/131] (475s left) i915_drm_fdinfo (most-busy-idle-check-all)
[542.856928] Starting subtest: most-busy-idle-check-all
[542.859400] Starting dynamic subtest: rcs0
[542.865078] Dynamic subtest rcs0: SKIP (0.004s)
[542.876883] Starting dynamic subtest: bcs0
[542.882257] Dynamic subtest bcs0: SKIP (0.000s)
[542.892671] Starting dynamic subtest: vcs0
[542.897199] Dynamic subtest vcs0: SKIP (0.001s)
[542.907133] Starting dynamic subtest: vcs1
[542.911419] Dynamic subtest vcs1: SKIP (0.000s)
[542.921078] Starting dynamic subtest: vecs0
[542.925425] Dynamic subtest vecs0: SKIP (0.000s)
[542.935378] Starting dynamic subtest: ccs0
[542.940115] Dynamic subtest ccs0: SKIP (0.000s)
[542.944593] Subtest most-busy-idle-check-all: SKIP (0.009s)
[542.983873] [056/131] (475s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[543.127358] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[543.132277] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[543.221834] [057/131] (475s left) kms_flip (2x-busy-flip)
[543.326943] Starting subtest: 2x-busy-flip
[543.338234] Subtest 2x-busy-flip: SKIP (0.011s)
[543.464013] [058/131] (475s left) gem_ctx_param (basic-default)
[543.522475] Starting subtest: basic-default
[543.525283] Subtest basic-default: SUCCESS (0.000s)
[543.602314] [059/131] (475s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[543.703517] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[548.368434] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.672s)
[549.500890] [060/131] (469s left) syncobj_timeline (single-wait-available-submitted)
[549.560901] Starting subtest: single-wait-available-submitted
[549.563554] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[549.680591] [061/131] (469s left) gem_partial_pwrite_pread (writes-after-reads)
[549.748323] Subtest writes-after-reads: SKIP (0.000s)
[549.820600] [062/131] (468s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[554.941140] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf
[554.946384] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.002s)
[555.789284] [063/131] (463s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[555.905706] Starting subtest: x-tiled-addfb-size-offset-overflow
[555.908176] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[555.995868] [064/131] (462s left) gem_pread (bench)
[556.048305] Subtest bench: SKIP (0.000s)
[556.108803] [065/131] (462s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[556.180383] Starting subtest: basic-batch-kernel-default-cmd
[556.185857] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[556.359888] [066/131] (462s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[556.453906] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[556.464450] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s)
[556.541698] [067/131] (462s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[556.806402] Starting subtest: cursor-rapid-movement-512x512
[556.812075] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[556.969376] [068/131] (462s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[557.077891] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[557.080462] Starting dynamic subtest: pipe-A-eDP-1
[557.511188] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.405s)
[557.522560] Starting dynamic subtest: pipe-B-eDP-1
[558.874878] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.357s)
[558.887113] Starting dynamic subtest: pipe-C-eDP-1
[560.277092] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.404s)
[560.287584] Starting dynamic subtest: pipe-D-eDP-1
[561.600881] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.319s)
[561.603261] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.489s)
[562.686343] [069/131] (456s left) kms_chamelium_frames (hdmi-aspect-ratio)
[563.085273] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[563.895686] [070/131] (455s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu)
[564.004161] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu
[570.589097] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (6.591s)
[570.727995] [071/131] (448s left) kms_flip (dpms-vs-vblank-race-interruptible)
[570.827574] Starting subtest: dpms-vs-vblank-race-interruptible
[570.830266] Starting dynamic subtest: A-eDP1
[575.784349] Dynamic subtest A-eDP1: SUCCESS (4.958s)
[575.796660] Starting dynamic subtest: B-eDP1
[580.376356] Dynamic subtest B-eDP1: SUCCESS (4.591s)
[580.393127] Starting dynamic subtest: C-eDP1
[584.960088] Dynamic subtest C-eDP1: SUCCESS (4.583s)
[584.971821] Starting dynamic subtest: D-eDP1
[589.543214] Dynamic subtest D-eDP1: SUCCESS (4.586s)
[589.545583] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (18.726s)
[590.420558] [072/131] (428s left) kms_psr (pr-cursor-mmap-cpu)
[590.530270] Starting subtest: pr-cursor-mmap-cpu
[590.535383] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[590.606238] [073/131] (428s left) api_intel_bb (intel-bb-blit-x)
[590.668430] Starting subtest: intel-bb-blit-x
[594.500818] Subtest intel-bb-blit-x: SUCCESS (3.834s)
[594.659691] [074/131] (424s left) i915_query (query-topology-matches-eu-total)
[594.720243] Starting subtest: query-topology-matches-eu-total
[594.722961] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[594.823260] [075/131] (424s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[594.918243] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc
[594.920584] Starting dynamic subtest: pipe-A-eDP-1
[594.945440] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[594.957016] Starting dynamic subtest: pipe-B-eDP-1
[594.981497] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[594.992159] Starting dynamic subtest: pipe-C-eDP-1
[595.017864] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[595.029145] Starting dynamic subtest: pipe-D-eDP-1
[595.054685] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[595.059133] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[597.067089] [076/131] (422s left) gem_eio (execbuf)
[597.302130] Starting subtest: execbuf
[597.643210] Subtest execbuf: SUCCESS (0.342s)
[597.823119] [077/131] (421s left) i915_pm_rps (min-max-config-loaded)
[597.877997] Starting subtest: min-max-config-loaded
[597.882972] Subtest min-max-config-loaded: SKIP (0.001s)
[597.963708] [078/131] (421s left) kms_lease (lessee-list)
[598.052608] Starting subtest: lessee-list
[598.054563] Starting dynamic subtest: pipe-A-eDP-1
[598.056354] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[598.067388] Starting dynamic subtest: pipe-B-eDP-1
[598.069449] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[598.080616] Starting dynamic subtest: pipe-C-eDP-1
[598.082938] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[598.093028] Starting dynamic subtest: pipe-D-eDP-1
[598.094828] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[598.096816] Subtest lessee-list: SUCCESS (0.008s)
[598.171573] [079/131] (421s left) device_reset (unbind-reset-rebind)
[598.216320] Starting subtest: unbind-reset-rebind
[602.956597] Subtest unbind-reset-rebind: SUCCESS (4.737s)
[603.001508] [080/131] (416s left) syncobj_wait (wait-any-snapshot)
[603.073794] Starting subtest: wait-any-snapshot
[603.154377] Subtest wait-any-snapshot: SUCCESS (0.082s)
[603.231924] [081/131] (416s left) gen9_exec_parse (unaligned-jump)
[603.293396] Subtest unaligned-jump: SKIP (0.000s)
[603.382424] [082/131] (416s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[603.501566] Starting subtest: flip-vs-cursor-atomic
[610.596770] Subtest flip-vs-cursor-atomic: SUCCESS (7.096s)
[611.425710] [083/131] (408s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[611.520249] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[611.522722] Starting dynamic subtest: pipe-A-default-mode
[612.680119] Dynamic subtest pipe-A-default-mode: SKIP (1.154s)
[612.685482] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.156s)
[612.833895] [084/131] (406s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[612.890169] Starting subtest: multi-wait-all-for-submit-available-signaled
[612.892462] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[613.006328] [085/131] (406s left) gem_exec_schedule (lateslice)
[613.086546] Starting subtest: lateslice
[613.088809] Starting dynamic subtest: rcs0
[613.101962] Dynamic subtest rcs0: SUCCESS (0.023s)
[613.113830] Starting dynamic subtest: bcs0
[613.119275] Dynamic subtest bcs0: SUCCESS (0.017s)
[613.130024] Starting dynamic subtest: vcs0
[613.135933] Dynamic subtest vcs0: SUCCESS (0.016s)
[613.146449] Starting dynamic subtest: vcs1
[613.152709] Dynamic subtest vcs1: SUCCESS (0.017s)
[613.163109] Starting dynamic subtest: vecs0
[613.173235] Dynamic subtest vecs0: SUCCESS (0.019s)
[613.183427] Starting dynamic subtest: ccs0
[613.192450] Dynamic subtest ccs0: SUCCESS (0.018s)
[613.194821] Subtest lateslice: SUCCESS (0.115s)
[615.152906] [086/131] (404s left) gem_exec_reloc (basic-gtt)
[615.215201] Subtest basic-gtt: SKIP (0.000s)
[615.302962] [087/131] (404s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[615.407624] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[615.412631] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[615.503454] [088/131] (404s left) perf (non-zero-reason)
[615.621093] Starting subtest: non-zero-reason
[615.623268] Starting dynamic subtest: 0-rcs0
[621.048358] Dynamic subtest 0-rcs0: SUCCESS (5.428s)
[621.061726] Starting dynamic subtest: 1-vcs1
[624.979972] Dynamic subtest 1-vcs1: SUCCESS (3.932s)
[624.982907] Subtest non-zero-reason: SUCCESS (9.362s)
[625.029383] [089/131] (394s left) kms_plane_cursor (viewport)
[625.118032] Starting subtest: viewport
[625.122870] Starting dynamic subtest: pipe-A-eDP-1-size-64
[628.106318] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.988s)
[628.166225] Starting dynamic subtest: pipe-A-eDP-1-size-128
[631.162809] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (3.004s)
[631.226789] Starting dynamic subtest: pipe-A-eDP-1-size-256
[634.117727] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.904s)
[634.464387] Starting dynamic subtest: pipe-B-eDP-1-size-64
[638.163625] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.712s)
[638.225514] Starting dynamic subtest: pipe-B-eDP-1-size-128
[641.174248] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.960s)
[641.237106] Starting dynamic subtest: pipe-B-eDP-1-size-256
[644.219591] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.994s)
[644.566182] Starting dynamic subtest: pipe-C-eDP-1-size-64
[647.767358] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (3.215s)
[647.807640] Starting dynamic subtest: pipe-C-eDP-1-size-128
[650.300261] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.502s)
[650.344886] Starting dynamic subtest: pipe-C-eDP-1-size-256
[652.799595] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.468s)
[653.128587] Starting dynamic subtest: pipe-D-eDP-1-size-64
[656.398402] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (3.282s)
[656.438414] Starting dynamic subtest: pipe-D-eDP-1-size-128
[658.965397] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.535s)
[659.003208] Starting dynamic subtest: pipe-D-eDP-1-size-256
[661.562333] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.568s)
[661.879302] Subtest viewport: SUCCESS (36.774s)
[662.722084] [090/131] (357s left) kms_flip (nonexisting-fb-interruptible)
[662.832994] Starting subtest: nonexisting-fb-interruptible
[662.835477] Starting dynamic subtest: A-eDP1
[663.998183] Dynamic subtest A-eDP1: SUCCESS (1.166s)
[664.009424] Starting dynamic subtest: B-eDP1
[665.132124] Dynamic subtest B-eDP1: SUCCESS (1.133s)
[665.145298] Starting dynamic subtest: C-eDP1
[666.255470] Dynamic subtest C-eDP1: SUCCESS (1.123s)
[666.266909] Starting dynamic subtest: D-eDP1
[667.383286] Dynamic subtest D-eDP1: SUCCESS (1.128s)
[667.385986] Subtest nonexisting-fb-interruptible: SUCCESS (4.557s)
[668.548681] [091/131] (351s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[668.659385] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[668.664588] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[668.776460] [092/131] (351s left) kms_tiled_display (basic-test-pattern)
[668.886877] Subtest basic-test-pattern: SKIP (0.000s)
[668.938577] [093/131] (351s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[669.037225] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[669.041200] Starting dynamic subtest: pipe-A-default-mode
[671.752430] Dynamic subtest pipe-A-default-mode: SUCCESS (2.712s)
[671.755091] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.714s)
[672.616099] [094/131] (347s left) gem_exec_endless (dispatch)
[672.691579] Starting subtest: dispatch
[672.694312] Starting dynamic subtest: rcs0
[672.699921] Dynamic subtest rcs0: SUCCESS (0.005s)
[672.715676] Starting dynamic subtest: bcs0
[672.721087] Dynamic subtest bcs0: SUCCESS (0.004s)
[672.732321] Starting dynamic subtest: vcs0
[672.737416] Dynamic subtest vcs0: SUCCESS (0.004s)
[672.747556] Starting dynamic subtest: vcs1
[672.752460] Dynamic subtest vcs1: SUCCESS (0.004s)
[672.762858] Starting dynamic subtest: vecs0
[672.767428] Dynamic subtest vecs0: SUCCESS (0.004s)
[672.777497] Starting dynamic subtest: ccs0
[672.782405] Dynamic subtest ccs0: SUCCESS (0.005s)
[672.784565] Subtest dispatch: SUCCESS (0.031s)
[674.093738] [095/131] (346s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[674.195567] Starting subtest: plane-all-transition-nonblocking-fencing
[674.198362] Starting dynamic subtest: pipe-A-eDP-1
[676.697596] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.503s)
[676.986956] Starting dynamic subtest: pipe-B-eDP-1
[680.233077] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.257s)
[680.512582] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.319s)
[681.346054] [096/131] (338s left) gem_mmap_gtt (cpuset-big-copy)
[681.409499] Subtest cpuset-big-copy: SKIP (0.000s)
[681.467576] [097/131] (338s left) kms_frontbuffer_tracking (basic)
[681.575864] Starting subtest: basic
[684.735121] Subtest basic: SUCCESS (3.167s)
[684.865127] [098/131] (335s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[684.926965] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[684.929009] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[685.047625] [099/131] (335s left) sysfs_heartbeat_interval (nopreempt)
[685.099990] Starting subtest: nopreempt
[685.102131] Starting dynamic subtest: vecs0
[695.050607] Dynamic subtest vecs0: SUCCESS (9.953s)
[695.064021] Starting dynamic subtest: ccs0
[699.039725] Dynamic subtest ccs0: SUCCESS (3.988s)
[699.052434] Starting dynamic subtest: vcs0
[709.062735] Dynamic subtest vcs0: SUCCESS (10.026s)
[709.076368] Starting dynamic subtest: bcs0
[713.086791] Dynamic subtest bcs0: SUCCESS (4.024s)
[713.101012] Starting dynamic subtest: rcs0
[717.155429] Dynamic subtest rcs0: SUCCESS (4.068s)
[717.171115] Starting dynamic subtest: vcs1
[727.061295] Dynamic subtest vcs1: SUCCESS (9.907s)
[727.063949] Subtest nopreempt: SUCCESS (41.976s)
[727.142989] [100/131] (293s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[727.247701] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[727.252226] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[727.356814] [101/131] (293s left) syncobj_timeline (multi-wait-available-submitted)
[727.410314] Starting subtest: multi-wait-available-submitted
[727.412435] Subtest multi-wait-available-submitted: SUCCESS (0.000s)
[727.513335] [102/131] (293s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[727.623699] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[727.628517] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[727.741928] [103/131] (292s left) kms_psr (fbc-psr2-no-drrs)
[727.838634] Starting subtest: fbc-psr2-no-drrs
[727.840807] Starting dynamic subtest: eDP-1
[727.845101] Dynamic subtest eDP-1: SKIP (0.000s)
[727.849858] Subtest fbc-psr2-no-drrs: SKIP (0.001s)
[727.912450] [104/131] (292s left) fbdev (unaligned-read)
[727.962156] Starting subtest: unaligned-read
[727.976795] Subtest unaligned-read: SUCCESS (0.015s)
[728.032568] [105/131] (292s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[728.121602] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[728.125599] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[728.226127] [106/131] (292s left) kms_async_flips (invalid-async-flip-atomic)
[728.323006] Starting subtest: invalid-async-flip-atomic
[728.326780] Subtest invalid-async-flip-atomic: SKIP (0.000s)
[729.546573] [107/131] (291s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[729.648497] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[734.249490] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (4.607s)
[735.439300] [108/131] (285s left) gem_exec_flush (basic-wb-ro-before-default)
[735.513806] Starting subtest: basic-wb-ro-before-default
[740.962599] Subtest basic-wb-ro-before-default: SUCCESS (5.451s)
[741.151117] [109/131] (279s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[741.252319] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[741.255007] Starting dynamic subtest: pipe-A-eDP-1
[741.305004] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.052s)
[741.317354] Starting dynamic subtest: pipe-B-eDP-1
[741.354188] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.048s)
[741.365634] Starting dynamic subtest: pipe-C-eDP-1
[741.406691] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.051s)
[741.417840] Starting dynamic subtest: pipe-D-eDP-1
[741.460541] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.053s)
[741.463588] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.209s)
[743.581568] [110/131] (277s left) kms_invalid_mode (zero-clock)
[743.678644] Starting subtest: zero-clock
[743.681460] Starting dynamic subtest: pipe-A-eDP-1
[743.962091] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[743.976184] Starting dynamic subtest: pipe-B-eDP-1
[743.978167] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[743.996809] Starting dynamic subtest: pipe-C-eDP-1
[743.999029] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[744.009460] Starting dynamic subtest: pipe-D-eDP-1
[744.011727] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[744.014062] Subtest zero-clock: SUCCESS (0.290s)
[744.806845] [111/131] (276s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[744.874439] Starting subtest: y-tiled-to-vebox-yf-tiled
[744.880315] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[745.057445] [112/131] (275s left) kms_pm_dc (dc5-psr)
[746.166457] Starting subtest: dc5-psr
[749.053274] Subtest dc5-psr: SUCCESS (2.889s)
[749.927108] [113/131] (271s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[750.029722] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[756.827706] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.805s)
[756.943906] [114/131] (264s left) gem_ctx_isolation (dirty-switch)
[757.013806] Starting subtest: dirty-switch
[757.016423] Starting dynamic subtest: rcs0
[757.457133] Dynamic subtest rcs0: SUCCESS (0.443s)
[757.470600] Starting dynamic subtest: bcs0
[757.918221] Dynamic subtest bcs0: SUCCESS (0.461s)
[757.929924] Starting dynamic subtest: vcs0
[758.372945] Dynamic subtest vcs0: SUCCESS (0.454s)
[758.385995] Starting dynamic subtest: vcs1
[760.495132] Dynamic subtest vcs1: SUCCESS (2.122s)
[760.506619] Starting dynamic subtest: vecs0
[762.539580] Dynamic subtest vecs0: SUCCESS (2.046s)
[762.553975] Starting dynamic subtest: ccs0
[764.485910] Dynamic subtest ccs0: SUCCESS (1.946s)
[764.489314] Subtest dirty-switch: SUCCESS (7.475s)
[764.729270] [115/131] (256s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt)
[764.834497] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt
[764.840210] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[764.920966] [116/131] (256s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[765.013227] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[765.015877] Starting dynamic subtest: pipe-A-eDP-1
[765.044153] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[765.056116] Starting dynamic subtest: pipe-B-eDP-1
[765.082926] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[765.093572] Starting dynamic subtest: pipe-C-eDP-1
[765.121337] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[765.131623] Starting dynamic subtest: pipe-D-eDP-1
[765.158584] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[765.163592] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[767.193559] [117/131] (253s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[767.295106] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[768.162316] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.870s)
[768.384288] [118/131] (252s left) kms_big_fb (yf-tiled-addfb)
[768.482138] Starting subtest: yf-tiled-addfb
[768.486347] Subtest yf-tiled-addfb: SKIP (0.000s)
[768.566168] [119/131] (252s left) perf (invalid-oa-metric-set-id)
[768.641324] Starting subtest: invalid-oa-metric-set-id
[768.660297] Subtest invalid-oa-metric-set-id: SUCCESS (0.016s)
[768.701445] [120/131] (252s left) kms_psr2_su (page_flip-p010)
[768.760059] Subtest page_flip-P010: SKIP (0.000s)
[768.826628] [121/131] (252s left) gem_lmem_swapping (smem-oom)
[768.866485] Subtest smem-oom: SKIP (0.000s)
[768.909698] [122/131] (252s left) kms_cursor_crc (cursor-suspend)
[769.033548] Starting subtest: cursor-suspend
[769.036049] Starting dynamic subtest: pipe-A-eDP-1
[802.238354] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.088s)
[802.250330] Starting dynamic subtest: pipe-D-eDP-1
[835.233268] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.636s)
[835.235287] Subtest cursor-suspend: SUCCESS (6.727s)
[836.138181] [123/131] (185s left) gem_pxp (create-regular-context-2)
[836.268873] Starting subtest: create-regular-context-2
[836.271287] Subtest create-regular-context-2: SUCCESS (0.002s)
[836.398086] [124/131] (185s left) gem_ctx_persistence (legacy-engines-hang)
[836.446693] Starting subtest: legacy-engines-hang
[836.449474] Starting dynamic subtest: render
[836.580998] Dynamic subtest render: SUCCESS (0.132s)
[836.594770] Starting dynamic subtest: bsd1
[836.700985] Dynamic subtest bsd1: SUCCESS (0.116s)
[836.715292] Starting dynamic subtest: bsd2
[836.811068] Dynamic subtest bsd2: SUCCESS (0.105s)
[836.825518] Starting dynamic subtest: blt
[836.905121] Dynamic subtest blt: SUCCESS (0.090s)
[836.920350] Starting dynamic subtest: vebox
[836.977131] Dynamic subtest vebox: SUCCESS (0.069s)
[836.979686] Subtest legacy-engines-hang: SUCCESS (0.524s)
[837.106740] [125/131] (184s left) kms_plane_alpha_blend (alpha-7efc)
[837.200942] Starting subtest: alpha-7efc
[837.626002] Starting dynamic subtest: pipe-A-eDP-1
[838.219946] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.585s)
[838.246073] Starting dynamic subtest: pipe-D-eDP-1
[839.549137] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.299s)
[839.551747] Subtest alpha-7efc: SUCCESS (2.322s)
[840.428541] [126/131] (181s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[840.531203] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[840.536384] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[840.633186] [127/131] (180s left) gem_userptr_blits (userfault)
[840.702993] Starting subtest: userfault
[840.705370] Subtest userfault: SUCCESS (0.006s)
[840.849040] [128/131] (180s left) i915_module_load (reload-no-display)
[840.880779] Starting subtest: reload-no-display
[845.995941] Subtest reload-no-display: SUCCESS (5.085s)
[846.028849] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[846.029559] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[846.033345] [129/131] (175s left) kms_chamelium_color (ctm-max)
[847.744533] Subtest ctm-max: SKIP (0.000s)
[847.800811] [FACT kms_chamelium_color (ctm-max)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[847.802789] [FACT kms_chamelium_color (ctm-max)] new: kernel.kmod_is_loaded.i915: true
[847.806612] [130/131] (173s left) kms_atomic_interruptible (legacy-pageflip)
[847.915294] Starting subtest: legacy-pageflip
[847.918192] Starting dynamic subtest: pipe-A-eDP-1
[855.313459] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.388s)
[855.315839] Subtest legacy-pageflip: SUCCESS (7.390s)
[856.132206] [131/131] (165s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[856.195338] Starting subtest: map-fixed-invalidate-overlap-busy
[856.200009] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s)
[856.333252] Closing watchdogs
results: parsing output: 0/ for test: kms_plane_scaling
results: parsing output: 1/ for test: gem_exec_reloc
results: parsing output: 2/ for test: kms_cursor_legacy
results: parsing output: 3/ for test: syncobj_timeline
results: parsing output: 4/ for test: kms_ccs
results: parsing output: 5/ for test: gem_ctx_shared
results: parsing output: 6/ for test: kms_addfb_basic
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: prime_busy
results: parsing output: 9/ for test: drm_read
results: parsing output: 10/ for test: kms_psr2_sf
results: parsing output: 11/ for test: gem_exec_balancer
results: parsing output: 12/ for test: gem_exec_schedule
results: parsing output: 13/ for test: gem_busy
results: parsing output: 14/ for test: kms_selftest
results: parsing output: 15/ for test: gem_exec_basic
results: parsing output: 16/ for test: kms_rotation_crc
results: parsing output: 17/ for test: syncobj_timeline
results: parsing output: 18/ for test: kms_psr
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: kms_busy
results: parsing output: 21/ for test: gem_busy
results: parsing output: 22/ for test: perf
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_cursor_legacy
results: parsing output: 25/ for test: kms_color
results: parsing output: 26/ for test: syncobj_wait
results: parsing output: 27/ for test: kms_getfb
results: parsing output: 28/ for test: perf_pmu
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_atomic_transition
results: parsing output: 31/ for test: kms_addfb_basic
results: parsing output: 32/ for test: prime_mmap
results: parsing output: 33/ for test: kms_cursor_crc
results: parsing output: 34/ for test: gem_gpgpu_fill
results: parsing output: 35/ for test: kms_flip
results: parsing output: 36/ for test: intel_sysfs_debugfs
results: parsing output: 37/ for test: kms_vblank
results: parsing output: 38/ for test: kms_pm_rpm
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: gem_render_copy
results: parsing output: 41/ for test: kms_plane_scaling
results: parsing output: 42/ for test: kms_big_fb
results: parsing output: 43/ for test: gem_exec_fence
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: syncobj_wait
results: parsing output: 47/ for test: gem_exec_schedule
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: gen9_exec_parse
results: parsing output: 51/ for test: kms_cursor_crc
results: parsing output: 52/ for test: kms_flip
results: parsing output: 53/ for test: kms_dirtyfb
results: parsing output: 54/ for test: i915_drm_fdinfo
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_flip
results: parsing output: 57/ for test: gem_ctx_param
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: syncobj_timeline
results: parsing output: 60/ for test: gem_partial_pwrite_pread
results: parsing output: 61/ for test: kms_psr2_sf
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: gem_pread
results: parsing output: 64/ for test: gem_exec_flush
results: parsing output: 65/ for test: kms_flip
results: parsing output: 66/ for test: kms_cursor_crc
results: parsing output: 67/ for test: kms_ccs
results: parsing output: 68/ for test: kms_chamelium_frames
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_flip
results: parsing output: 71/ for test: kms_psr
results: parsing output: 72/ for test: api_intel_bb
results: parsing output: 73/ for test: i915_query
results: parsing output: 74/ for test: kms_ccs
results: parsing output: 75/ for test: gem_eio
results: parsing output: 76/ for test: i915_pm_rps
results: parsing output: 77/ for test: kms_lease
results: parsing output: 78/ for test: device_reset
results: parsing output: 79/ for test: syncobj_wait
results: parsing output: 80/ for test: gen9_exec_parse
results: parsing output: 81/ for test: kms_cursor_legacy
results: parsing output: 82/ for test: kms_flip_scaled_crc
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: gem_exec_schedule
results: parsing output: 85/ for test: gem_exec_reloc
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: perf
results: parsing output: 88/ for test: kms_plane_cursor
results: parsing output: 89/ for test: kms_flip
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_tiled_display
results: parsing output: 92/ for test: kms_flip_scaled_crc
results: parsing output: 93/ for test: gem_exec_endless
results: parsing output: 94/ for test: kms_atomic_transition
results: parsing output: 95/ for test: gem_mmap_gtt
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: syncobj_wait
results: parsing output: 98/ for test: sysfs_heartbeat_interval
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: kms_psr
results: parsing output: 103/ for test: fbdev
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_async_flips
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_exec_flush
results: parsing output: 108/ for test: kms_ccs
results: parsing output: 109/ for test: kms_invalid_mode
results: parsing output: 110/ for test: gem_render_copy
results: parsing output: 111/ for test: kms_pm_dc
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_ctx_isolation
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_ccs
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: perf
results: parsing output: 119/ for test: kms_psr2_su
results: parsing output: 120/ for test: gem_lmem_swapping
results: parsing output: 121/ for test: kms_cursor_crc
results: parsing output: 122/ for test: gem_pxp
results: parsing output: 123/ for test: gem_ctx_persistence
results: parsing output: 124/ for test: kms_plane_alpha_blend
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gem_userptr_blits
results: parsing output: 127/ for test: i915_module_load
results: parsing output: 128/ for test: kms_chamelium_color
results: parsing output: 129/ for test: kms_atomic_interruptible
results: parsing output: 130/ for test: gem_userptr_blits
Done.