[153.913741] Initializing watchdogs
[153.913788]   /dev/watchdog0
[153.927712] [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]
[153.932167] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[153.934379] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[153.937729] [001/133] (960s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[154.070374] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[154.072741] Starting dynamic subtest: pipe-A-eDP-1
[154.095813] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[154.106075] Starting dynamic subtest: pipe-B-eDP-1
[154.128198] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[154.134606] Starting dynamic subtest: pipe-C-eDP-1
[154.156321] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[154.163412] Starting dynamic subtest: pipe-D-eDP-1
[154.185647] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[154.189786] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.003s)
[156.287896] [002/133] (958s left) perf_pmu (busy-double-start)
[156.334841] Starting subtest: busy-double-start
[156.337145] Starting dynamic subtest: rcs0
[159.970864] Dynamic subtest rcs0: FAIL (3.577s)
[159.979956] Starting dynamic subtest: bcs0
[163.517218] Dynamic subtest bcs0: SUCCESS (3.604s)
[163.526835] Starting dynamic subtest: vcs0
[167.477701] Dynamic subtest vcs0: SUCCESS (3.960s)
[167.487459] Starting dynamic subtest: vcs1
[171.457346] Dynamic subtest vcs1: SUCCESS (3.978s)
[171.467373] Starting dynamic subtest: vecs0
[175.474223] Dynamic subtest vecs0: SUCCESS (4.016s)
[175.484179] Starting dynamic subtest: ccs0
[179.106946] Dynamic subtest ccs0: FAIL (3.564s)
[179.109328] Subtest busy-double-start: FAIL (22.704s)
[179.172346] [003/133] (935s left) sw_sync (sync_merge)
[179.224061] Starting subtest: sync_merge
[179.226558] Subtest sync_merge: SUCCESS (0.000s)
[179.281888] [004/133] (935s left) gem_pread (self)
[179.344071] Subtest self: SKIP (0.000s)
[179.413334] [005/133] (935s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[179.538116] Starting subtest: flip-vs-cursor-crc-atomic
[180.235401] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.695s)
[181.118281] [006/133] (933s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[181.222220] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[181.224641] Starting dynamic subtest: pipe-A-eDP-1
[181.283403] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.063s)
[181.589059] Starting dynamic subtest: pipe-B-eDP-1
[182.421555] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.840s)
[182.719584] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.498s)
[183.591011] [007/133] (931s left) gem_exec_gttfill (multigpu-basic)
[183.771785] Starting subtest: multigpu-basic
[205.001358] Subtest multigpu-basic: SUCCESS (21.232s)
[205.045421] [008/133] (909s left) kms_psr (fbc-pr-basic)
[205.179171] Starting subtest: fbc-pr-basic
[205.183742] Subtest fbc-pr-basic: SKIP (0.000s)
[205.262218] [009/133] (909s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[205.360760] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[212.255796] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.897s)
[212.439782] [010/133] (902s left) gem_exec_whisper (basic-sync)
[212.506725] Starting subtest: basic-sync
[219.209980] Subtest basic-sync: SUCCESS (6.704s)
[219.404477] [011/133] (895s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[219.512091] Starting subtest: yf-tiled-32bpp-rotate-270
[219.516745] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[219.646912] [012/133] (895s left) gem_exec_schedule (u-fairslice)
[219.732415] Starting subtest: u-fairslice
[219.734391] Starting dynamic subtest: rcs0
[221.746681] Dynamic subtest rcs0: SUCCESS (2.020s)
[221.756754] Starting dynamic subtest: bcs0
[223.787935] Dynamic subtest bcs0: SUCCESS (2.015s)
[223.796286] Starting dynamic subtest: vcs0
[225.784816] Dynamic subtest vcs0: SUCCESS (2.023s)
[225.794682] Starting dynamic subtest: vcs1
[227.804139] Dynamic subtest vcs1: SUCCESS (2.018s)
[227.814151] Starting dynamic subtest: vecs0
[229.821781] Dynamic subtest vecs0: SUCCESS (2.017s)
[229.831411] Starting dynamic subtest: ccs0
[231.841185] Dynamic subtest ccs0: SUCCESS (2.020s)
[231.843522] Subtest u-fairslice: SUCCESS (12.115s)
[232.148399] [013/133] (882s left) kms_psr (psr2-suspend)
[232.253762] Starting subtest: psr2-suspend
[232.256069] Starting dynamic subtest: eDP-1
[249.889419] Dynamic subtest eDP-1: SUCCESS (3.867s)
[249.892416] Subtest psr2-suspend: SUCCESS (3.868s)
[250.770683] [014/133] (864s left) syncobj_wait (multi-wait-all-submitted)
[250.844527] Starting subtest: multi-wait-all-submitted
[250.953722] Subtest multi-wait-all-submitted: SUCCESS (0.108s)
[251.041130] [015/133] (863s left) gem_softpin (noreloc-s3)
[251.105101] Starting subtest: noreloc-S3
[271.568425] Subtest noreloc-S3: SUCCESS (5.423s)
[271.715891] [016/133] (843s left) i915_pm_freq_api (freq-basic-api)
[271.790151] Starting subtest: freq-basic-api
[271.792635] Starting dynamic subtest: gt0
[271.797440] Dynamic subtest gt0: SUCCESS (0.006s)
[271.808276] Starting dynamic subtest: gt1
[271.810503] Dynamic subtest gt1: SUCCESS (0.003s)
[271.812664] Subtest freq-basic-api: SUCCESS (0.009s)
[271.906935] [017/133] (843s left) kms_psr (fbc-psr-no-drrs)
[272.005340] Starting subtest: fbc-psr-no-drrs
[272.007740] Starting dynamic subtest: eDP-1
[272.011904] Dynamic subtest eDP-1: SKIP (0.000s)
[272.016105] Subtest fbc-psr-no-drrs: SKIP (0.001s)
[272.109891] [018/133] (843s left) kms_cursor_edge_walk (256x256-left-edge)
[272.207496] Starting subtest: 256x256-left-edge
[272.209756] Starting dynamic subtest: pipe-A-eDP-1
[275.669673] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.461s)
[275.683147] Starting dynamic subtest: pipe-D-eDP-1
[278.806189] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.134s)
[278.808109] Subtest 256x256-left-edge: SUCCESS (6.597s)
[279.616219] [019/133] (835s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0-hflip)
[279.717644] Starting subtest: linear-max-hw-stride-64bpp-rotate-0-hflip
[279.721793] Subtest linear-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[279.836326] [020/133] (835s left) syncobj_timeline (wait-all-for-submit-complex)
[279.899128] Starting subtest: wait-all-for-submit-complex
[280.113780] Subtest wait-all-for-submit-complex: SUCCESS (0.214s)
[280.206034] [021/133] (835s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[280.372059] Starting subtest: cursor-rapid-movement-32x10
[280.422590] Subtest cursor-rapid-movement-32x10: SKIP (0.045s)
[280.709208] [022/133] (834s left) prime_busy (after)
[280.776099] Starting subtest: after
[280.778451] Starting dynamic subtest: rcs0
[280.819081] Dynamic subtest rcs0: SUCCESS (0.042s)
[280.830313] Starting dynamic subtest: bcs0
[280.882326] Dynamic subtest bcs0: SUCCESS (0.062s)
[280.893063] Starting dynamic subtest: vcs0
[280.921710] Dynamic subtest vcs0: SUCCESS (0.040s)
[280.930966] Starting dynamic subtest: vcs1
[280.962198] Dynamic subtest vcs1: SUCCESS (0.040s)
[280.972643] Starting dynamic subtest: vecs0
[281.003342] Dynamic subtest vecs0: SUCCESS (0.041s)
[281.013893] Starting dynamic subtest: ccs0
[281.043315] Dynamic subtest ccs0: SUCCESS (0.040s)
[281.152454] Subtest after: SUCCESS (0.376s)
[281.243145] [023/133] (834s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[281.319376] Subtest writes-after-reads: SKIP (0.000s)
[281.420327] [024/133] (833s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[281.523435] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[281.527946] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[281.642447] [025/133] (833s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[281.737385] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[281.741888] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.000s)
[281.819330] [026/133] (833s left) kms_flip (2x-flip-vs-modeset)
[281.925664] Starting subtest: 2x-flip-vs-modeset
[281.937380] Subtest 2x-flip-vs-modeset: SKIP (0.011s)
[282.065870] [027/133] (833s left) gen7_exec_parse (basic-offset)
[282.130071] Subtest basic-offset: SKIP (0.000s)
[282.200525] [028/133] (833s left) i915_drm_fdinfo (busy-check-all)
[282.242843] Starting subtest: busy-check-all
[282.244780] Starting dynamic subtest: rcs0
[282.248500] Dynamic subtest rcs0: SKIP (0.004s)
[282.262860] Starting dynamic subtest: bcs0
[282.266560] Dynamic subtest bcs0: SKIP (0.000s)
[282.274894] Starting dynamic subtest: vcs0
[282.278418] Dynamic subtest vcs0: SKIP (0.000s)
[282.286469] Starting dynamic subtest: vcs1
[282.290153] Dynamic subtest vcs1: SKIP (0.000s)
[282.298293] Starting dynamic subtest: vecs0
[282.301923] Dynamic subtest vecs0: SKIP (0.000s)
[282.309997] Starting dynamic subtest: ccs0
[282.313573] Dynamic subtest ccs0: SKIP (0.000s)
[282.317114] Subtest busy-check-all: SKIP (0.008s)
[282.349829] [029/133] (833s left) gem_exec_reloc (basic-gtt-active)
[282.426455] Subtest basic-gtt-active: SKIP (0.000s)
[282.505068] [030/133] (833s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[282.621355] Starting subtest: 4-tiled-8bpp-rotate-270
[282.642317] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.020s)
[282.798387] [031/133] (832s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[282.896428] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[282.899892] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[283.013650] [032/133] (832s left) gem_mmap_wc (coherency)
[283.080774] Subtest coherency: SKIP (0.000s)
[283.152080] [033/133] (832s left) gem_softpin (evict-snoop)
[283.216889] Starting subtest: evict-snoop
[283.220649] Subtest evict-snoop: SKIP (0.000s)
[283.360958] [034/133] (832s left) kms_setmode (basic)
[283.424545] Starting subtest: basic
[283.752259] Starting dynamic subtest: pipe-A-eDP-1
[285.824417] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.068s)
[286.174165] Starting dynamic subtest: pipe-B-eDP-1
[288.259270] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.089s)
[288.566885] Subtest basic: SUCCESS (5.140s)
[289.407034] [035/133] (826s left) i915_selftest (perf)
[292.181831] Starting subtest: perf
[292.185064] Starting dynamic subtest: engine_cs
[296.697301] Dynamic subtest engine_cs: SUCCESS (4.514s)
[296.706848] Starting dynamic subtest: request
[304.032615] Dynamic subtest request: SUCCESS (7.334s)
[304.042668] Starting dynamic subtest: migrate
[308.505762] Dynamic subtest migrate: SUCCESS (4.471s)
[308.515763] Starting dynamic subtest: region
[314.707417] Dynamic subtest region: SUCCESS (6.200s)
[314.709974] Subtest perf: SUCCESS (22.524s)
[314.739698] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[314.742932] [036/133] (801s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[316.349617] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf
[316.354275] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[316.441632] [FACT kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)] new: kernel.kmod_is_loaded.i915: true
[316.445157] [037/133] (799s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[316.548594] Starting subtest: plane-scaler-unity-scaling-with-rotation
[316.550792] Starting dynamic subtest: pipe-A
[316.837526] Dynamic subtest pipe-A: SUCCESS (0.290s)
[316.848478] Starting dynamic subtest: pipe-B
[318.143668] Dynamic subtest pipe-B: SUCCESS (1.306s)
[318.153658] Starting dynamic subtest: pipe-C
[319.458911] Dynamic subtest pipe-C: SUCCESS (1.314s)
[319.468299] Starting dynamic subtest: pipe-D
[320.776677] Dynamic subtest pipe-D: SUCCESS (1.317s)
[320.779054] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.230s)
[321.972155] [038/133] (793s left) gem_mmap_gtt (basic-read)
[322.035876] Subtest basic-read: SKIP (0.000s)
[322.105886] [039/133] (793s left) kms_properties (plane-properties-atomic)
[322.211504] Starting subtest: plane-properties-atomic
[322.213425] Starting dynamic subtest: pipe-A-eDP-1
[322.764868] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.553s)
[322.773850] Starting dynamic subtest: pipe-B-eDP-1
[324.029630] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.263s)
[324.038173] Starting dynamic subtest: pipe-C-eDP-1
[325.269385] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.239s)
[325.280405] Starting dynamic subtest: pipe-D-eDP-1
[326.505778] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.233s)
[326.507998] Subtest plane-properties-atomic: SUCCESS (4.294s)
[327.319399] [040/133] (788s left) kms_color (invalid-gamma-lut-sizes)
[327.412278] Starting subtest: invalid-gamma-lut-sizes
[327.414586] Starting dynamic subtest: pipe-A
[327.700831] Dynamic subtest pipe-A: SUCCESS (0.290s)
[327.711430] Starting dynamic subtest: pipe-B
[327.713723] Dynamic subtest pipe-B: SUCCESS (0.000s)
[327.723818] Starting dynamic subtest: pipe-C
[327.726049] Dynamic subtest pipe-C: SUCCESS (0.000s)
[327.734699] Starting dynamic subtest: pipe-D
[327.737111] Dynamic subtest pipe-D: SUCCESS (0.000s)
[327.739446] Subtest invalid-gamma-lut-sizes: SUCCESS (0.293s)
[328.538944] [041/133] (787s left) dmabuf_sync_file (export-before-signal)
[328.603804] Starting subtest: export-before-signal
[328.606195] Subtest export-before-signal: SUCCESS (0.001s)
[328.670496] [FACT dmabuf_sync_file (export-before-signal)] new: kernel.kmod_is_loaded.vgem: true
[328.673699] [042/133] (787s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw)
[328.776481] Starting subtest: psr-1p-pri-indfb-multidraw
[351.687841] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (22.915s)
[351.803891] [043/133] (764s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[351.906766] Starting subtest: compare-crc-sanitycheck-xr24
[351.908465] Starting dynamic subtest: pipe-A-eDP-1
[352.539169] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.629s)
[352.549100] Starting dynamic subtest: pipe-B-eDP-1
[353.801929] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.264s)
[353.812206] Starting dynamic subtest: pipe-C-eDP-1
[355.002678] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.199s)
[355.012267] Starting dynamic subtest: pipe-D-eDP-1
[356.230585] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.227s)
[356.232944] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.325s)
[357.089019] [044/133] (759s left) gem_readwrite (new-obj)
[357.150606] Subtest new-obj: SKIP (0.000s)
[357.214389] [045/133] (758s left) i915_pm_freq_mult (media-freq)
[357.273512] Starting subtest: media-freq
[357.275827] Starting dynamic subtest: gt0
[357.280212] Dynamic subtest gt0: SKIP (0.000s)
[357.289274] Starting dynamic subtest: gt1
[357.293634] Dynamic subtest gt1: SKIP (0.000s)
[357.297980] Subtest media-freq: SKIP (0.002s)
[357.392737] [046/133] (758s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[357.496811] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[357.501133] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[357.635556] [047/133] (758s left) kms_cursor_crc (cursor-offscreen-512x170)
[357.934916] Starting subtest: cursor-offscreen-512x170
[357.938652] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[358.096696] [048/133] (758s left) perf (i915-ref-count)
[358.198569] Starting subtest: i915-ref-count
[358.267594] Subtest i915-ref-count: SUCCESS (0.068s)
[358.337335] [049/133] (758s left) kms_async_flips (alternate-sync-async-flip)
[358.422424] Starting subtest: alternate-sync-async-flip
[358.791043] Starting dynamic subtest: pipe-A-eDP-1
[361.574280] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.783s)
[361.957524] Starting dynamic subtest: pipe-B-eDP-1
[364.700885] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.751s)
[365.087496] Starting dynamic subtest: pipe-C-eDP-1
[367.844613] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.766s)
[368.212791] Starting dynamic subtest: pipe-D-eDP-1
[370.973065] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.768s)
[370.975109] Subtest alternate-sync-async-flip: SUCCESS (12.553s)
[372.154133] [050/133] (744s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[372.221964] Starting subtest: invalid-multi-wait-unsubmitted
[372.224377] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[372.346832] [051/133] (744s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[372.444472] Starting subtest: primary-y-tiled-reflect-x-270
[372.448479] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[372.534728] [052/133] (743s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[372.636339] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[372.638772] Starting dynamic subtest: pipe-A-eDP-1
[373.544445] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.901s)
[373.553656] Starting dynamic subtest: pipe-B-eDP-1
[375.101926] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.554s)
[375.120756] Starting dynamic subtest: pipe-C-eDP-1
[376.574640] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.471s)
[376.584812] Starting dynamic subtest: pipe-D-eDP-1
[378.019015] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.445s)
[378.021272] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.376s)
[379.212930] [053/133] (737s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[379.322438] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[385.858443] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.538s)
[386.005914] [054/133] (730s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[386.106757] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[386.110798] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[386.242366] [055/133] (730s left) gem_mmap_offset (close-race)
[386.307725] Starting subtest: close-race
[406.425564] Subtest close-race: SUCCESS (20.116s)
[406.570260] [056/133] (710s left) vgem_basic (dmabuf-export)
[406.624178] Starting subtest: dmabuf-export
[406.681522] Subtest dmabuf-export: SUCCESS (0.059s)
[406.817340] [057/133] (709s left) syncobj_eventfd (timeline-wait)
[406.874460] Starting subtest: timeline-wait
[406.883521] Subtest timeline-wait: SUCCESS (0.010s)
[406.971165] [058/133] (709s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[407.068026] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[407.072113] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.000s)
[407.164473] [059/133] (709s left) gem_exec_whisper (basic-normal-all)
[407.228921] Starting subtest: basic-normal-all
[409.533879] Subtest basic-normal-all: SUCCESS (2.305s)
[409.733274] [060/133] (707s left) kms_big_fb (linear-8bpp-rotate-0)
[409.861942] Starting subtest: linear-8bpp-rotate-0
[411.077008] Subtest linear-8bpp-rotate-0: SUCCESS (1.214s)
[411.191335] [061/133] (705s left) fbdev (unaligned-write)
[411.238035] Starting subtest: unaligned-write
[411.342841] Subtest unaligned-write: SUCCESS (0.102s)
[411.417150] [062/133] (705s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[411.518081] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[411.520152] Starting dynamic subtest: pipe-A-eDP-1
[412.376073] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.853s)
[412.385898] Starting dynamic subtest: pipe-B-eDP-1
[413.989136] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.608s)
[414.001408] Starting dynamic subtest: pipe-C-eDP-1
[415.587050] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.598s)
[415.597793] Starting dynamic subtest: pipe-D-eDP-1
[417.083064] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.495s)
[417.085357] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.559s)
[418.262651] [063/133] (698s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[418.373800] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[418.378026] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[418.476370] [064/133] (698s left) gem_exec_reloc (basic-wc-read-active)
[418.545587] Subtest basic-wc-read-active: SKIP (0.000s)
[418.634586] [065/133] (698s left) gem_userptr_blits (nohangcheck)
[418.706260] Starting subtest: nohangcheck
[418.976262] Subtest nohangcheck: SUCCESS (0.266s)
[419.113545] [066/133] (697s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[419.215323] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[419.217619] Starting dynamic subtest: A-eDP1
[428.090519] Dynamic subtest A-eDP1: SUCCESS (8.874s)
[428.104076] Starting dynamic subtest: B-eDP1
[437.017882] Dynamic subtest B-eDP1: SUCCESS (8.925s)
[437.029297] Starting dynamic subtest: C-eDP1
[445.941218] Dynamic subtest C-eDP1: SUCCESS (8.921s)
[445.955665] Starting dynamic subtest: D-eDP1
[454.871860] Dynamic subtest D-eDP1: SUCCESS (8.928s)
[454.876525] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.658s)
[456.114244] [067/133] (661s left) kms_getfb (getfb2-handle-zero)
[456.211158] Starting subtest: getfb2-handle-zero
[456.213470] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[456.335853] [068/133] (660s left) gem_partial_pwrite_pread (writes-after-reads)
[456.398067] Subtest writes-after-reads: SKIP (0.000s)
[456.478178] [069/133] (660s left) prime_mmap (test_map_unmap)
[456.540723] Starting subtest: test_map_unmap
[456.542955] Starting dynamic subtest: test_map_unmap-smem
[456.570578] Dynamic subtest test_map_unmap-smem: SUCCESS (0.032s)
[456.573235] Subtest test_map_unmap: SUCCESS (0.033s)
[456.704903] [070/133] (660s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[456.804450] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[456.806715] Starting dynamic subtest: pipe-A-eDP-1
[456.866863] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[456.878085] Starting dynamic subtest: pipe-B-eDP-1
[456.934765] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[456.945546] Starting dynamic subtest: pipe-C-eDP-1
[457.003945] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[457.013588] Starting dynamic subtest: pipe-D-eDP-1
[457.061705] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[457.064970] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[458.984074] [071/133] (658s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[459.097415] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[459.101547] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[459.201500] [072/133] (658s left) kms_prime (basic-crc-vgem)
[459.285998] Starting subtest: basic-crc-vgem
[459.288331] Starting dynamic subtest: second-to-first
[460.224323] Dynamic subtest second-to-first: SUCCESS (0.941s)
[460.226293] Subtest basic-crc-vgem: SUCCESS (0.941s)
[460.338407] [073/133] (657s left) gem_ctx_persistence (legacy-engines-hang)
[460.429398] Starting subtest: legacy-engines-hang
[460.431423] Starting dynamic subtest: render
[460.574025] Dynamic subtest render: SUCCESS (0.143s)
[460.588785] Starting dynamic subtest: bsd1
[460.685694] Dynamic subtest bsd1: SUCCESS (0.109s)
[460.698188] Starting dynamic subtest: bsd2
[460.809700] Dynamic subtest bsd2: SUCCESS (0.121s)
[460.819531] Starting dynamic subtest: blt
[460.887530] Dynamic subtest blt: SUCCESS (0.076s)
[460.900443] Starting dynamic subtest: vebox
[461.032709] Dynamic subtest vebox: SUCCESS (0.142s)
[461.035006] Subtest legacy-engines-hang: SUCCESS (0.604s)
[461.124208] [074/133] (656s left) kms_psr (fbc-pr-sprite-plane-move)
[461.226026] Starting subtest: fbc-pr-sprite-plane-move
[461.229778] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[461.330310] [075/133] (656s left) vgem_slow (nohang)
[461.373552] Starting subtest: nohang
[471.800474] Subtest nohang: SUCCESS (10.426s)
[471.884036] [076/133] (645s left) gem_ctx_persistence (engines-hostile)
[471.967832] Starting subtest: engines-hostile
[471.970169] Starting dynamic subtest: rcs0
[472.108022] Dynamic subtest rcs0: SUCCESS (0.140s)
[472.120183] Starting dynamic subtest: bcs0
[472.188542] Dynamic subtest bcs0: SUCCESS (0.079s)
[472.199387] Starting dynamic subtest: vcs0
[472.352965] Dynamic subtest vcs0: SUCCESS (0.162s)
[472.365025] Starting dynamic subtest: vcs1
[472.482925] Dynamic subtest vcs1: SUCCESS (0.128s)
[472.495075] Starting dynamic subtest: vecs0
[472.604209] Dynamic subtest vecs0: SUCCESS (0.119s)
[472.615866] Starting dynamic subtest: ccs0
[472.731157] Dynamic subtest ccs0: SUCCESS (0.125s)
[472.733609] Subtest engines-hostile: SUCCESS (0.765s)
[472.827458] [077/133] (644s left) syncobj_basic (bad-destroy)
[472.896527] Starting subtest: bad-destroy
[472.898437] Subtest bad-destroy: SUCCESS (0.000s)
[473.020639] [078/133] (644s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[473.127111] Starting subtest: fbc-rgb565-draw-blt
[477.306960] Subtest fbc-rgb565-draw-blt: SUCCESS (4.183s)
[478.479793] [079/133] (639s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[478.594039] Starting subtest: psr2-cursor-plane-update-sf
[478.596466] Starting dynamic subtest: pipe-A-eDP-1
[479.158839] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.570s)
[479.169132] Starting dynamic subtest: pipe-B-eDP-1
[480.453880] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.292s)
[480.455799] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.865s)
[481.337939] [080/133] (636s left) kms_lease (lease-invalid-plane)
[481.454317] Starting subtest: lease-invalid-plane
[481.456535] Starting dynamic subtest: pipe-A-eDP-1
[481.458864] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[481.468419] Starting dynamic subtest: pipe-B-eDP-1
[481.470630] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[481.479711] Starting dynamic subtest: pipe-C-eDP-1
[481.481969] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[481.491175] Starting dynamic subtest: pipe-D-eDP-1
[481.493381] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[481.495575] Subtest lease-invalid-plane: SUCCESS (0.004s)
[481.557243] [081/133] (636s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[481.682752] Starting subtest: yf-tiled-8bpp-rotate-0
[481.687163] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[481.815367] [082/133] (635s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt)
[481.917978] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt
[481.921925] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[482.045602] [083/133] (635s left) kms_atomic (crtc-invalid-params-fence)
[482.143518] Starting subtest: crtc-invalid-params-fence
[482.145736] Starting dynamic subtest: pipe-A-eDP-1
[482.571528] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.426s)
[482.573488] Subtest crtc-invalid-params-fence: SUCCESS (0.427s)
[483.383677] [084/133] (634s left) gem_softpin (32b-excludes-last-page)
[483.443078] Starting subtest: 32b-excludes-last-page
[483.445349] Subtest 32b-excludes-last-page: SUCCESS (0.003s)
[483.613085] [085/133] (634s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[483.704987] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[483.708965] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[483.823724] [086/133] (634s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[483.924845] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[483.929035] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[484.059509] [087/133] (633s left) prime_vgem (basic-read)
[484.130142] Starting subtest: basic-read
[484.136601] Subtest basic-read: SKIP (0.004s)
[484.257279] [088/133] (633s left) kms_plane (pixel-format-yf-tiled-ccs-modifier)
[484.353034] Starting subtest: pixel-format-yf-tiled-ccs-modifier
[484.379792] Starting dynamic subtest: pipe-A-plane-0
[484.383162] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[484.392908] Starting dynamic subtest: pipe-A-plane-3
[484.396658] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[484.405268] Starting dynamic subtest: pipe-A-plane-5
[484.409128] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[485.466516] Starting dynamic subtest: pipe-B-plane-0
[485.470789] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[485.480443] Starting dynamic subtest: pipe-B-plane-3
[485.484128] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[485.493761] Starting dynamic subtest: pipe-B-plane-5
[485.498146] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[485.784099] Subtest pixel-format-yf-tiled-ccs-modifier: SKIP (1.426s)
[486.657023] [089/133] (631s left) syncobj_timeline (invalid-query-zero-handles)
[486.719503] Starting subtest: invalid-query-zero-handles
[486.721820] Subtest invalid-query-zero-handles: SUCCESS (0.000s)
[486.823697] [090/133] (631s left) perf_pmu (invalid-open)
[486.862737] Starting subtest: invalid-open
[486.864984] Subtest invalid-open: SUCCESS (0.000s)
[486.985778] [091/133] (631s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[487.088618] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[487.092530] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[487.206130] [092/133] (630s left) kms_busy (extended-modeset-hang-oldfb)
[487.305696] Starting subtest: extended-modeset-hang-oldfb
[487.307829] Starting dynamic subtest: pipe-A
[499.239000] Dynamic subtest pipe-A: SUCCESS (11.931s)
[499.252067] Starting dynamic subtest: pipe-D
[511.511963] Dynamic subtest pipe-D: SUCCESS (12.268s)
[511.514586] Subtest extended-modeset-hang-oldfb: SUCCESS (24.208s)
[512.314051] [093/133] (605s left) gem_exec_fence (syncobj-timeline-chain-engines)
[512.842433] Starting subtest: syncobj-timeline-chain-engines
[512.944233] Subtest syncobj-timeline-chain-engines: SUCCESS (0.102s)
[513.828908] [094/133] (604s left) kms_rotation_crc (primary-rotation-90)
[513.926850] Starting subtest: primary-rotation-90
[513.931376] Subtest primary-rotation-90: SKIP (0.001s)
[514.020697] [095/133] (604s left) kms_chamelium_hpd (dp-hpd-fast)
[514.402670] Subtest dp-hpd-fast: SKIP (0.000s)
[515.200312] [096/133] (603s left) gem_create (create-ext-cpu-access-sanity-check)
[515.384566] Starting subtest: create-ext-cpu-access-sanity-check
[515.389162] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[515.458114] [097/133] (602s left) vgem_basic (bad-flag)
[515.498935] Starting subtest: bad-flag
[515.501286] Subtest bad-flag: SUCCESS (0.000s)
[515.574020] [098/133] (602s left) kms_pm_backlight (fade-with-dpms)
[515.673478] Starting subtest: fade-with-dpms
[518.235602] Starting dynamic subtest: eDP-1
[520.930095] Dynamic subtest eDP-1: SUCCESS (2.695s)
[520.932292] Subtest fade-with-dpms: SUCCESS (5.257s)
[521.744247] [099/133] (596s left) gem_exec_fence (basic-wait)
[521.923132] Starting subtest: basic-wait
[521.925629] Starting dynamic subtest: rcs0
[522.006009] Dynamic subtest rcs0: SUCCESS (0.083s)
[522.018227] Starting dynamic subtest: bcs0
[522.065963] Dynamic subtest bcs0: SUCCESS (0.058s)
[522.077492] Starting dynamic subtest: vcs0
[522.127460] Dynamic subtest vcs0: SUCCESS (0.059s)
[522.140549] Starting dynamic subtest: vcs1
[522.189582] Dynamic subtest vcs1: SUCCESS (0.060s)
[522.201307] Starting dynamic subtest: vecs0
[522.253111] Dynamic subtest vecs0: SUCCESS (0.062s)
[522.264790] Starting dynamic subtest: ccs0
[522.310547] Dynamic subtest ccs0: SUCCESS (0.055s)
[522.312946] Subtest basic-wait: SUCCESS (0.390s)
[523.813544] [100/133] (594s left) core_getclient (basic)
[523.865777] Starting subtest: basic
[523.867756] Subtest basic: SUCCESS (0.000s)
[524.007978] [101/133] (594s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[524.113159] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[524.117357] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[524.257445] [102/133] (594s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[524.319945] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[524.322306] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[524.444320] [103/133] (594s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[524.509004] Starting subtest: yf-tiled-ccs-to-yf-tiled
[524.513684] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[524.706670] [104/133] (593s left) gem_exec_schedule (pi-common)
[524.892861] Starting subtest: pi-common
[524.895096] Starting dynamic subtest: rcs0
[524.917831] Dynamic subtest rcs0: SUCCESS (0.028s)
[524.932182] Starting dynamic subtest: bcs0
[524.945551] Dynamic subtest bcs0: SUCCESS (0.027s)
[524.960237] Starting dynamic subtest: vcs0
[524.972434] Dynamic subtest vcs0: SUCCESS (0.026s)
[524.987269] Starting dynamic subtest: vcs1
[524.998987] Dynamic subtest vcs1: SUCCESS (0.026s)
[525.013539] Starting dynamic subtest: vecs0
[525.025996] Dynamic subtest vecs0: SUCCESS (0.026s)
[525.040826] Starting dynamic subtest: ccs0
[525.052976] Dynamic subtest ccs0: SUCCESS (0.026s)
[525.055151] Subtest pi-common: SUCCESS (0.164s)
[525.315174] [105/133] (593s left) gem_mmap_gtt (cpuset-medium-copy-odd)
[525.375271] Subtest cpuset-medium-copy-odd: SKIP (0.000s)
[525.445838] [106/133] (593s left) kms_vblank (ts-continuation-dpms-rpm)
[525.546793] Starting subtest: ts-continuation-dpms-rpm
[525.548738] Starting dynamic subtest: pipe-A-eDP-1
[528.023478] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.476s)
[528.037415] Starting dynamic subtest: pipe-D-eDP-1
[530.278062] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.253s)
[530.280409] Subtest ts-continuation-dpms-rpm: SUCCESS (4.733s)
[531.087311] [107/133] (587s left) gem_ctx_shared (single-timeline)
[531.160454] Starting subtest: single-timeline
[531.178534] Subtest single-timeline: SUCCESS (0.013s)
[531.428791] [108/133] (587s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[531.533022] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[531.537592] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[531.667575] [109/133] (587s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[531.777069] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[531.781217] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[531.911076] [110/133] (587s left) gem_exec_params (invalid-ring2)
[531.974415] Starting subtest: invalid-ring2
[531.976839] Subtest invalid-ring2: SUCCESS (0.000s)
[532.109428] [111/133] (586s left) kms_dirtyfb (default-dirtyfb-ioctl)
[532.227610] Starting subtest: default-dirtyfb-ioctl
[532.230029] Starting dynamic subtest: A-eDP-1
[533.824711] Dynamic subtest A-eDP-1: SUCCESS (1.596s)
[533.826587] Subtest default-dirtyfb-ioctl: SUCCESS (1.598s)
[534.645099] [112/133] (584s left) kms_psr (pr-primary-render)
[534.744381] Starting subtest: pr-primary-render
[534.748623] Subtest pr-primary-render: SKIP (0.000s)
[534.829883] [113/133] (584s left) gem_ctx_bad_destroy (double-destroy)
[534.898357] Starting subtest: double-destroy
[534.900611] Subtest double-destroy: SUCCESS (0.000s)
[534.998758] [114/133] (584s left) kms_plane_scaling (planes-downscale-factor-0-75)
[535.115451] Starting subtest: planes-downscale-factor-0-75
[535.117569] Starting dynamic subtest: pipe-A
[535.139481] Dynamic subtest pipe-A: SKIP (0.019s)
[535.149889] Starting dynamic subtest: pipe-B
[535.172013] Dynamic subtest pipe-B: SKIP (0.032s)
[535.181711] Starting dynamic subtest: pipe-C
[535.206819] Dynamic subtest pipe-C: SKIP (0.033s)
[535.216458] Starting dynamic subtest: pipe-D
[535.241528] Dynamic subtest pipe-D: SKIP (0.033s)
[535.245708] Subtest planes-downscale-factor-0-75: SKIP (0.122s)
[535.343223] [115/133] (583s left) kms_plane_multiple (tiling-none)
[535.449181] Starting subtest: tiling-none
[535.451462] Starting dynamic subtest: pipe-A-eDP-1
[539.227405] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.780s)
[539.241307] Starting dynamic subtest: pipe-B-eDP-1
[543.668893] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.440s)
[543.679052] Starting dynamic subtest: pipe-C-eDP-1
[548.039965] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.369s)
[548.050417] Starting dynamic subtest: pipe-D-eDP-1
[552.367749] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.326s)
[552.369950] Subtest tiling-none: SUCCESS (16.921s)
[553.191156] [116/133] (566s left) kms_draw_crc (draw-method-mmap-cpu)
[553.291349] Starting subtest: draw-method-mmap-cpu
[553.293444] Starting dynamic subtest: xrgb8888-untiled
[553.534970] Dynamic subtest xrgb8888-untiled: SUCCESS (0.245s)
[553.545438] Starting dynamic subtest: rgb565-untiled
[553.768265] Dynamic subtest rgb565-untiled: SUCCESS (0.231s)
[553.778843] Starting dynamic subtest: xrgb2101010-untiled
[553.990218] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s)
[554.002251] Starting dynamic subtest: xbgr16161616f-untiled
[554.234804] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.244s)
[554.245560] Starting dynamic subtest: xrgb8888-xtiled
[554.367902] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.131s)
[554.378272] Starting dynamic subtest: rgb565-xtiled
[554.501422] Dynamic subtest rgb565-xtiled: SUCCESS (0.133s)
[554.515969] Starting dynamic subtest: xrgb2101010-xtiled
[554.634507] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.133s)
[554.644504] Starting dynamic subtest: xbgr16161616f-xtiled
[554.767936] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[554.777887] Starting dynamic subtest: xrgb8888-4tiled
[554.901310] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.133s)
[554.913078] Starting dynamic subtest: rgb565-4tiled
[555.034455] Dynamic subtest rgb565-4tiled: SUCCESS (0.131s)
[555.043791] Starting dynamic subtest: xrgb2101010-4tiled
[555.156659] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.122s)
[555.166449] Starting dynamic subtest: xbgr16161616f-4tiled
[555.290273] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.133s)
[555.292149] Subtest draw-method-mmap-cpu: SUCCESS (2.001s)
[555.399125] [117/133] (563s left) kms_psr (psr-primary-page-flip)
[555.483820] Starting subtest: psr-primary-page-flip
[555.485656] Starting dynamic subtest: eDP-1
[557.174305] Dynamic subtest eDP-1: SUCCESS (1.690s)
[557.176485] Subtest psr-primary-page-flip: SUCCESS (1.691s)
[558.073604] [118/133] (561s left) kms_content_protection (dp-mst-type-0-hdcp14)
[558.232475] Starting subtest: dp-mst-type-0-hdcp14
[558.237076] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s)
[558.380627] [119/133] (560s left) api_intel_allocator (alloc-simple)
[558.437797] Starting subtest: alloc-simple
[558.440084] Subtest alloc-simple: SUCCESS (0.003s)
[558.603174] [120/133] (560s left) gem_spin_batch (resubmit-new-all)
[558.667583] Starting subtest: resubmit-new-all
[558.669772] Starting dynamic subtest: rcs0
[558.682082] Dynamic subtest rcs0: SUCCESS (0.014s)
[558.691632] Starting dynamic subtest: bcs0
[558.693848] Dynamic subtest bcs0: SUCCESS (0.010s)
[558.703339] Starting dynamic subtest: vcs0
[558.705547] Dynamic subtest vcs0: SUCCESS (0.008s)
[558.714976] Starting dynamic subtest: vcs1
[558.716823] Dynamic subtest vcs1: SUCCESS (0.008s)
[558.726854] Starting dynamic subtest: vecs0
[558.728973] Dynamic subtest vecs0: SUCCESS (0.009s)
[558.738916] Starting dynamic subtest: ccs0
[558.740736] Dynamic subtest ccs0: SUCCESS (0.009s)
[558.742543] Subtest resubmit-new-all: SUCCESS (0.063s)
[560.787614] [121/133] (558s left) kms_joiner (invalid-modeset-ultra-joiner)
[560.888669] Starting subtest: invalid-modeset-ultra-joiner
[560.892818] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[560.969800] [122/133] (558s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[561.101596] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[561.106693] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[561.279241] [123/133] (558s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[561.655819] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[562.456986] [124/133] (557s left) gem_userptr_blits (unsync-overlap)
[562.520504] Subtest unsync-overlap: SKIP (0.000s)
[562.643745] [125/133] (556s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[562.750795] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[562.755194] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[562.886847] [126/133] (556s left) kms_sequence (get-busy)
[562.977682] Starting subtest: get-busy
[562.979941] Starting dynamic subtest: pipe-A-eDP-1
[564.912114] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.934s)
[564.922728] Starting dynamic subtest: pipe-B-eDP-1
[567.475781] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.564s)
[567.486804] Starting dynamic subtest: pipe-C-eDP-1
[570.061249] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.585s)
[570.072315] Starting dynamic subtest: pipe-D-eDP-1
[572.606711] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.544s)
[572.609132] Subtest get-busy: SUCCESS (9.632s)
[573.419524] [127/133] (546s left) gem_exec_balancer (hang)
[573.685782] Starting subtest: hang
[575.732598] Subtest hang: SUCCESS (2.047s)
[575.878584] [128/133] (543s left) kms_cdclk (plane-scaling)
[575.975238] Starting subtest: plane-scaling
[575.977473] Starting dynamic subtest: pipe-A-eDP-1
[576.271326] Dynamic subtest pipe-A-eDP-1: SKIP (0.292s)
[576.281937] Starting dynamic subtest: pipe-B-eDP-1
[576.286568] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[576.296592] Starting dynamic subtest: pipe-C-eDP-1
[576.301232] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[576.310969] Starting dynamic subtest: pipe-D-eDP-1
[576.315324] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[576.319646] Subtest plane-scaling: SKIP (0.300s)
[577.151617] [129/133] (542s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[577.251427] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[577.255658] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[577.377550] [130/133] (542s left) kms_flip (flip-vs-wf_vblank-interruptible)
[577.476727] Starting subtest: flip-vs-wf_vblank-interruptible
[577.479041] Starting dynamic subtest: A-eDP1
[579.386602] Dynamic subtest A-eDP1: SUCCESS (1.908s)
[579.398629] Starting dynamic subtest: B-eDP1
[581.312194] Dynamic subtest B-eDP1: SUCCESS (1.924s)
[581.327722] Starting dynamic subtest: C-eDP1
[583.235587] Dynamic subtest C-eDP1: SUCCESS (1.920s)
[583.251967] Starting dynamic subtest: D-eDP1
[585.158435] Dynamic subtest D-eDP1: SUCCESS (1.922s)
[585.163544] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.685s)
[586.411920] [131/133] (533s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[586.513144] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[586.517290] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[586.638138] [132/133] (533s left) gem_mmap_wc (set-cache-level)
[586.699267] Subtest set-cache-level: SKIP (0.000s)
[586.768685] [133/133] (533s left) gem_exec_params (cliprects_ptr-dirt)
[586.835416] Starting subtest: cliprects_ptr-dirt
[586.837648] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[586.958692] Closing watchdogs
results: parsing output: 0/ for test: kms_ccs
results: parsing output: 1/ for test: perf_pmu
results: parsing output: 2/ for test: sw_sync
results: parsing output: 3/ for test: gem_pread
results: parsing output: 4/ for test: kms_cursor_legacy
results: parsing output: 5/ for test: kms_atomic_transition
results: parsing output: 6/ for test: gem_exec_gttfill
results: parsing output: 7/ for test: kms_psr
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: gem_exec_whisper
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: gem_exec_schedule
results: parsing output: 12/ for test: kms_psr
results: parsing output: 13/ for test: syncobj_wait
results: parsing output: 14/ for test: gem_softpin
results: parsing output: 15/ for test: i915_pm_freq_api
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: kms_cursor_edge_walk
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: syncobj_timeline
results: parsing output: 20/ for test: kms_cursor_crc
results: parsing output: 21/ for test: prime_busy
results: parsing output: 22/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: kms_flip_scaled_crc
results: parsing output: 25/ for test: kms_flip
results: parsing output: 26/ for test: gen7_exec_parse
results: parsing output: 27/ for test: i915_drm_fdinfo
results: parsing output: 28/ for test: gem_exec_reloc
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: gem_mmap_wc
results: parsing output: 32/ for test: gem_softpin
results: parsing output: 33/ for test: kms_setmode
results: parsing output: 34/ for test: i915_selftest
results: parsing output: 35/ for test: kms_psr2_sf
results: parsing output: 36/ for test: kms_plane_scaling
results: parsing output: 37/ for test: gem_mmap_gtt
results: parsing output: 38/ for test: kms_properties
results: parsing output: 39/ for test: kms_color
results: parsing output: 40/ for test: dmabuf_sync_file
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_pipe_crc_basic
results: parsing output: 43/ for test: gem_readwrite
results: parsing output: 44/ for test: i915_pm_freq_mult
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_cursor_crc
results: parsing output: 47/ for test: perf
results: parsing output: 48/ for test: kms_async_flips
results: parsing output: 49/ for test: syncobj_timeline
results: parsing output: 50/ for test: kms_rotation_crc
results: parsing output: 51/ for test: kms_ccs
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gem_mmap_offset
results: parsing output: 55/ for test: vgem_basic
results: parsing output: 56/ for test: syncobj_eventfd
results: parsing output: 57/ for test: kms_flip_scaled_crc
results: parsing output: 58/ for test: gem_exec_whisper
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: fbdev
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_exec_reloc
results: parsing output: 64/ for test: gem_userptr_blits
results: parsing output: 65/ for test: kms_flip
results: parsing output: 66/ for test: kms_getfb
results: parsing output: 67/ for test: gem_partial_pwrite_pread
results: parsing output: 68/ for test: prime_mmap
results: parsing output: 69/ for test: kms_ccs
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_prime
results: parsing output: 72/ for test: gem_ctx_persistence
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: vgem_slow
results: parsing output: 75/ for test: gem_ctx_persistence
results: parsing output: 76/ for test: syncobj_basic
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_psr2_sf
results: parsing output: 79/ for test: kms_lease
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_atomic
results: parsing output: 83/ for test: gem_softpin
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: prime_vgem
results: parsing output: 87/ for test: kms_plane
results: parsing output: 88/ for test: syncobj_timeline
results: parsing output: 89/ for test: perf_pmu
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_busy
results: parsing output: 92/ for test: gem_exec_fence
results: parsing output: 93/ for test: kms_rotation_crc
results: parsing output: 94/ for test: kms_chamelium_hpd
results: parsing output: 95/ for test: gem_create
results: parsing output: 96/ for test: vgem_basic
results: parsing output: 97/ for test: kms_pm_backlight
results: parsing output: 98/ for test: gem_exec_fence
results: parsing output: 99/ for test: core_getclient
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: syncobj_timeline
results: parsing output: 102/ for test: gem_render_copy
results: parsing output: 103/ for test: gem_exec_schedule
results: parsing output: 104/ for test: gem_mmap_gtt
results: parsing output: 105/ for test: kms_vblank
results: parsing output: 106/ for test: gem_ctx_shared
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: gem_exec_params
results: parsing output: 110/ for test: kms_dirtyfb
results: parsing output: 111/ for test: kms_psr
results: parsing output: 112/ for test: gem_ctx_bad_destroy
results: parsing output: 113/ for test: kms_plane_scaling
results: parsing output: 114/ for test: kms_plane_multiple
results: parsing output: 115/ for test: kms_draw_crc
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: kms_content_protection
results: parsing output: 118/ for test: api_intel_allocator
results: parsing output: 119/ for test: gem_spin_batch
results: parsing output: 120/ for test: kms_joiner
results: parsing output: 121/ for test: kms_cursor_legacy
results: parsing output: 122/ for test: kms_chamelium_frames
results: parsing output: 123/ for test: gem_userptr_blits
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_sequence
results: parsing output: 126/ for test: gem_exec_balancer
results: parsing output: 127/ for test: kms_cdclk
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_flip
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: gem_mmap_wc
results: parsing output: 132/ for test: gem_exec_params
Done.