[58.407524] Initializing watchdogs
[58.407571]   /dev/watchdog0
[58.421806] [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]
[58.426250] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.428474] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.431763] [001/133] (960s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf)
[58.546774] Starting subtest: fbc-psr2-overlay-plane-move-continuous-sf
[58.549261] Starting dynamic subtest: pipe-A-eDP-1
[58.669732] Dynamic subtest pipe-A-eDP-1: SKIP (0.126s)
[58.680110] Starting dynamic subtest: pipe-B-eDP-1
[59.805071] Dynamic subtest pipe-B-eDP-1: SKIP (1.134s)
[59.809785] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (1.261s)
[61.027972] [002/133] (957s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[61.133603] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[61.136102] Starting dynamic subtest: pipe-A-eDP-1
[61.159459] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[61.168913] Starting dynamic subtest: pipe-B-eDP-1
[61.191029] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[61.198336] Starting dynamic subtest: pipe-C-eDP-1
[61.219873] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[61.226917] Starting dynamic subtest: pipe-D-eDP-1
[61.251025] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[61.255585] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[63.387643] [003/133] (955s left) kms_sequence (queue-busy)
[63.494477] Starting subtest: queue-busy
[63.496924] Starting dynamic subtest: pipe-A-eDP-1
[65.425945] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.932s)
[65.435066] Starting dynamic subtest: pipe-B-eDP-1
[68.062021] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.636s)
[68.070975] Starting dynamic subtest: pipe-C-eDP-1
[70.670687] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.608s)
[70.679749] Starting dynamic subtest: pipe-D-eDP-1
[73.224428] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.553s)
[73.226868] Subtest queue-busy: SUCCESS (9.733s)
[74.032793] [004/133] (945s left) i915_query (test-query-geometry-subslices)
[74.098314] Starting subtest: test-query-geometry-subslices
[74.100739] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[74.203028] [005/133] (944s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[74.308611] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[75.353820] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.045s)
[75.584213] [006/133] (943s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[75.690916] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[75.702267] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.011s)
[75.806885] [007/133] (943s left) gem_mmap_offset (mmap-unmap)
[75.869884] Starting subtest: mmap-unmap
[75.871516] Starting dynamic subtest: smem0
[99.887494] Dynamic subtest smem0: SUCCESS (24.018s)
[99.890240] Subtest mmap-unmap: SUCCESS (24.019s)
[100.020991] [008/133] (919s left) kms_plane_scaling (planes-scaler-unity-scaling)
[100.136721] Starting subtest: planes-scaler-unity-scaling
[100.139076] Starting dynamic subtest: pipe-A
[100.198364] Dynamic subtest pipe-A: SUCCESS (0.064s)
[100.207760] Starting dynamic subtest: pipe-B
[101.340835] Dynamic subtest pipe-B: SUCCESS (1.142s)
[101.350732] Starting dynamic subtest: pipe-C
[102.455701] Dynamic subtest pipe-C: SUCCESS (1.115s)
[102.464376] Starting dynamic subtest: pipe-D
[103.576039] Dynamic subtest pipe-D: SUCCESS (1.120s)
[103.578475] Subtest planes-scaler-unity-scaling: SUCCESS (3.442s)
[104.746543] [009/133] (914s left) kms_hdr (static-toggle)
[104.838872] Starting subtest: static-toggle
[104.845697] Subtest static-toggle: SKIP (0.000s)
[104.943525] [010/133] (914s left) gem_exec_gttfill (basic)
[105.018593] Starting subtest: basic
[107.659744] Subtest basic: SUCCESS (2.639s)
[107.859223] [011/133] (911s left) kms_flip (flip-vs-rmfb-interruptible)
[108.001181] Starting subtest: flip-vs-rmfb-interruptible
[108.003454] Starting dynamic subtest: A-eDP1
[116.724156] Dynamic subtest A-eDP1: SUCCESS (8.723s)
[116.733813] Starting dynamic subtest: B-eDP1
[125.363956] Dynamic subtest B-eDP1: SUCCESS (8.639s)
[125.373083] Starting dynamic subtest: C-eDP1
[133.982209] Dynamic subtest C-eDP1: SUCCESS (8.617s)
[133.991796] Starting dynamic subtest: D-eDP1
[142.610490] Dynamic subtest D-eDP1: SUCCESS (8.627s)
[142.615241] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.614s)
[143.799493] [012/133] (875s left) gem_exec_reloc (basic-active)
[143.874055] Subtest basic-active: SKIP (0.000s)
[143.962579] [013/133] (875s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[144.091221] Starting subtest: short-flip-before-cursor-toggle
[145.016669] Subtest short-flip-before-cursor-toggle: SUCCESS (0.926s)
[145.832015] [014/133] (873s left) gen3_render_mixed_blits
[145.938153] [015/133] (873s left) api_intel_bb (render-ccs)
[145.989753] Starting subtest: render-ccs
[146.343253] Subtest render-ccs: SUCCESS (0.354s)
[146.452921] [016/133] (873s left) kms_pipe_crc_basic (suspend-read-crc)
[146.547302] Starting subtest: suspend-read-crc
[146.549510] Starting dynamic subtest: pipe-A-eDP-1
[164.460921] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.680s)
[164.470493] Starting dynamic subtest: pipe-B-eDP-1
[182.462495] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.204s)
[182.474340] Starting dynamic subtest: pipe-C-eDP-1
[200.405457] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.071s)
[200.414270] Starting dynamic subtest: pipe-D-eDP-1
[219.156556] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.795s)
[219.159310] Subtest suspend-read-crc: SUCCESS (12.760s)
[219.588842] [017/133] (800s left) gem_ctx_isolation (dirty-switch)
[219.694677] Starting subtest: dirty-switch
[219.697183] Starting dynamic subtest: rcs0
[219.894418] Dynamic subtest rcs0: SUCCESS (0.201s)
[219.905317] Starting dynamic subtest: bcs0
[220.133224] Dynamic subtest bcs0: SUCCESS (0.238s)
[220.144323] Starting dynamic subtest: vcs0
[220.363162] Dynamic subtest vcs0: SUCCESS (0.229s)
[220.372668] Starting dynamic subtest: vcs1
[221.991468] Dynamic subtest vcs1: SUCCESS (1.625s)
[222.001406] Starting dynamic subtest: vecs0
[223.997366] Dynamic subtest vecs0: SUCCESS (2.002s)
[224.008681] Starting dynamic subtest: ccs0
[225.960557] Dynamic subtest ccs0: SUCCESS (1.960s)
[225.963346] Subtest dirty-switch: SUCCESS (6.261s)
[226.190597] [018/133] (793s left) kms_content_protection (dp-mst-lic-type-1)
[226.337665] Starting subtest: dp-mst-lic-type-1
[226.342197] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[226.496494] [019/133] (793s left) gem_mmap_gtt (big-bo-tiledy)
[226.554977] Subtest big-bo-tiledY: SKIP (0.000s)
[226.621750] [020/133] (793s left) gem_bad_reloc (negative-reloc-bltcopy)
[226.674236] Subtest negative-reloc-bltcopy: SKIP (0.000s)
[226.737729] [021/133] (793s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[226.801033] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[226.910187] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.107s)
[226.998646] [022/133] (792s left) gen7_exec_parse (basic-rejected)
[227.052206] Subtest basic-rejected: SKIP (0.000s)
[227.118232] [023/133] (792s left) gem_eio (kms)
[227.380401] Starting subtest: kms
[246.080564] Subtest kms: SUCCESS (18.687s)
[247.280998] [FACT gem_eio (kms)] new: kernel.kmod_is_loaded.vgem: true
[247.284559] [024/133] (772s left) gem_exec_schedule (preempt-queue-contexts)
[247.370927] Subtest preempt-queue-contexts: SKIP (0.000s)
[247.682428] [025/133] (772s left) gem_exec_fence (invalid-timeline-fence-array)
[248.214767] Starting subtest: invalid-timeline-fence-array
[248.221319] Subtest invalid-timeline-fence-array: SUCCESS (0.006s)
[249.875903] [026/133] (770s left) gem_exec_reloc (basic-cpu-active)
[249.932894] Subtest basic-cpu-active: SKIP (0.000s)
[250.000701] [027/133] (770s left) kms_psr (fbc-psr2-dpms)
[250.097148] Starting subtest: fbc-psr2-dpms
[250.099608] Starting dynamic subtest: eDP-1
[250.103994] Dynamic subtest eDP-1: SKIP (0.000s)
[250.108371] Subtest fbc-psr2-dpms: SKIP (0.001s)
[250.197519] [028/133] (769s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[250.294341] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[250.296579] Starting dynamic subtest: pipe-A-eDP-1
[261.590778] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.301s)
[261.601034] Starting dynamic subtest: pipe-B-eDP-1
[273.577984] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.986s)
[273.580304] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (23.290s)
[274.448242] [029/133] (745s left) kms_getfb (getfb-addfb-different-handles)
[274.559835] Starting subtest: getfb-addfb-different-handles
[274.562054] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[274.700822] [030/133] (745s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[274.806617] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[274.810577] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[274.935090] [031/133] (745s left) gem_softpin (evict-prime)
[275.004004] Starting subtest: evict-prime
[275.006601] Starting dynamic subtest: rcs0
[276.176667] Dynamic subtest rcs0: SUCCESS (1.172s)
[276.189515] Starting dynamic subtest: bcs0
[277.316562] Dynamic subtest bcs0: SUCCESS (1.138s)
[277.328760] Starting dynamic subtest: vcs0
[278.754078] Dynamic subtest vcs0: SUCCESS (1.434s)
[278.766440] Starting dynamic subtest: vcs1
[280.747154] Dynamic subtest vcs1: SUCCESS (1.990s)
[280.760550] Starting dynamic subtest: vecs0
[282.709131] Dynamic subtest vecs0: SUCCESS (1.959s)
[282.725204] Starting dynamic subtest: ccs0
[283.855585] Dynamic subtest ccs0: SUCCESS (1.145s)
[283.867417] Starting dynamic subtest: all
[285.742133] Dynamic subtest all: SUCCESS (1.882s)
[285.744886] Subtest evict-prime: SUCCESS (10.735s)
[285.838250] [032/133] (734s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[285.904313] Starting subtest: single-wait-for-submit-available-signaled
[285.906769] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[286.048383] [033/133] (734s left) kms_psr (psr2-primary-render)
[286.154478] Starting subtest: psr2-primary-render
[286.156790] Starting dynamic subtest: eDP-1
[287.908076] Dynamic subtest eDP-1: SUCCESS (1.752s)
[287.910343] Subtest psr2-primary-render: SUCCESS (1.753s)
[288.791568] [034/133] (731s left) gem_mmap_gtt (basic-small-copy-odd)
[288.851807] Subtest basic-small-copy-odd: SKIP (0.000s)
[288.919851] [035/133] (731s left) kms_cursor_crc (cursor-onscreen-128x42)
[289.148987] Starting subtest: cursor-onscreen-128x42
[289.196693] Subtest cursor-onscreen-128x42: SKIP (0.041s)
[289.439464] [036/133] (730s left) kms_busy (extended-pageflip-hang-oldfb)
[289.549157] Starting subtest: extended-pageflip-hang-oldfb
[289.551549] Starting dynamic subtest: pipe-A
[289.941792] Dynamic subtest pipe-A: SUCCESS (0.394s)
[289.952090] Starting dynamic subtest: pipe-D
[291.097942] Dynamic subtest pipe-D: SUCCESS (1.151s)
[291.100487] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.550s)
[291.954080] [037/133] (728s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[292.058395] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf
[292.062565] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[292.141291] [038/133] (728s left) syncobj_basic (bad-destroy)
[292.194567] Starting subtest: bad-destroy
[292.196827] Subtest bad-destroy: SUCCESS (0.000s)
[292.310280] [039/133] (728s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[292.417100] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[299.426891] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.009s)
[299.578872] [040/133] (721s left) prime_mmap (test_forked_cpu_write)
[299.639668] Starting subtest: test_forked_cpu_write
[299.641933] Starting dynamic subtest: test_forked_cpu_write-smem
[299.646214] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.009s)
[299.648420] Subtest test_forked_cpu_write: SUCCESS (0.010s)
[299.748256] [041/133] (720s left) i915_drm_fdinfo (most-busy-idle-check-all)
[299.796205] Starting subtest: most-busy-idle-check-all
[299.798608] Starting dynamic subtest: rcs0
[299.803302] Dynamic subtest rcs0: SKIP (0.003s)
[299.818196] Starting dynamic subtest: bcs0
[299.822663] Dynamic subtest bcs0: SKIP (0.000s)
[299.832472] Starting dynamic subtest: vcs0
[299.836452] Dynamic subtest vcs0: SKIP (0.000s)
[299.845694] Starting dynamic subtest: vcs1
[299.849575] Dynamic subtest vcs1: SKIP (0.001s)
[299.858568] Starting dynamic subtest: vecs0
[299.862585] Dynamic subtest vecs0: SKIP (0.000s)
[299.872209] Starting dynamic subtest: ccs0
[299.876238] Dynamic subtest ccs0: SKIP (0.000s)
[299.880279] Subtest most-busy-idle-check-all: SKIP (0.011s)
[299.921671] [042/133] (720s left) kms_big_fb (linear-16bpp-rotate-90)
[300.072249] Starting subtest: linear-16bpp-rotate-90
[300.091922] Subtest linear-16bpp-rotate-90: SKIP (0.019s)
[300.241768] [043/133] (720s left) i915_pm_rpm (system-suspend-devices)
[301.965002] Starting subtest: system-suspend-devices
[309.623830] Subtest system-suspend-devices: SUCCESS (7.657s)
[310.000738] [044/133] (710s left) gem_exec_store (cachelines)
[310.081104] Starting subtest: cachelines
[310.083486] Starting dynamic subtest: rcs0
[310.210870] Dynamic subtest rcs0: SUCCESS (0.132s)
[310.223384] Starting dynamic subtest: bcs0
[310.276123] Dynamic subtest bcs0: SUCCESS (0.064s)
[310.288225] Starting dynamic subtest: vcs0
[310.336167] Dynamic subtest vcs0: SUCCESS (0.058s)
[310.347852] Starting dynamic subtest: vcs1
[310.397703] Dynamic subtest vcs1: SUCCESS (0.060s)
[310.409082] Starting dynamic subtest: vecs0
[310.465984] Dynamic subtest vecs0: SUCCESS (0.066s)
[310.477490] Starting dynamic subtest: ccs0
[310.530992] Dynamic subtest ccs0: SUCCESS (0.063s)
[310.533392] Subtest cachelines: SUCCESS (0.455s)
[310.732261] [045/133] (710s left) gem_eio (wait-10ms)
[310.978707] Starting subtest: wait-10ms
[311.371280] Subtest wait-10ms: SUCCESS (0.392s)
[311.546526] [046/133] (709s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[311.664649] Starting subtest: basic-busy-flip-before-cursor-atomic
[311.668261] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[311.817110] [047/133] (709s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[311.914103] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[311.917638] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.000s)
[312.011163] [048/133] (708s left) kms_cursor_crc (cursor-sliding-128x128)
[312.204939] Starting subtest: cursor-sliding-128x128
[312.209614] Starting dynamic subtest: pipe-A-eDP-1
[315.487672] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.277s)
[315.517826] Starting dynamic subtest: pipe-D-eDP-1
[319.393074] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.881s)
[319.395325] Subtest cursor-sliding-128x128: SUCCESS (7.186s)
[320.270267] [049/133] (700s left) core_hotunplug (unbind-rebind)
[320.372012] Starting subtest: unbind-rebind
[326.437389] Subtest unbind-rebind: SUCCESS (6.067s)
[326.478565] [050/133] (694s left) kms_chamelium_color (gamma)
[327.773059] Subtest gamma: SKIP (0.000s)
[327.855247] [051/133] (693s left) gem_ctx_exec (basic-close-race)
[327.922864] Starting subtest: basic-close-race
[333.975687] Subtest basic-close-race: SUCCESS (6.051s)
[334.116817] [052/133] (687s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[334.214085] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[334.218119] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[334.330341] [053/133] (686s left) gem_eio (in-flight-external)
[334.551163] Starting subtest: in-flight-external
[335.760928] Subtest in-flight-external: SUCCESS (1.209s)
[335.941064] [054/133] (685s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[336.042358] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[336.046513] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[336.157182] [055/133] (685s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[336.279747] Starting subtest: verify-pxp-execution-after-suspend-resume
[343.356112] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.077s)
[343.528283] [056/133] (677s left) kms_psr (pr-basic)
[343.636982] Starting subtest: pr-basic
[343.641396] Subtest pr-basic: SKIP (0.000s)
[343.724771] [057/133] (677s left) kms_psr (fbc-psr-cursor-mmap-cpu)
[343.821227] Starting subtest: fbc-psr-cursor-mmap-cpu
[343.823575] Starting dynamic subtest: eDP-1
[343.827822] Dynamic subtest eDP-1: SKIP (0.000s)
[343.832227] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.001s)
[343.907763] [058/133] (677s left) kms_vrr (flip-suspend)
[344.003576] Starting subtest: flip-suspend
[344.009892] Subtest flip-suspend: SKIP (0.000s)
[344.095542] [059/133] (677s left) intel_hwmon (hwmon-write)
[344.155124] Subtest hwmon-write: SKIP (0.000s)
[344.220546] [060/133] (677s left) kms_vblank (ts-continuation-suspend)
[344.320985] Starting subtest: ts-continuation-suspend
[344.322840] Starting dynamic subtest: pipe-A-eDP-1
[360.833027] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.561s)
[360.848358] Starting dynamic subtest: pipe-D-eDP-1
[377.836141] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.170s)
[377.838726] Subtest ts-continuation-suspend: SUCCESS (3.735s)
[378.653822] [061/133] (642s left) kms_plane (pixel-format-yf-tiled-ccs-modifier-source-clamping)
[378.769209] Starting subtest: pixel-format-yf-tiled-ccs-modifier-source-clamping
[378.774154] Subtest pixel-format-yf-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[378.873268] [062/133] (642s left) kms_dsc (dsc-with-formats)
[378.980219] Starting subtest: dsc-with-formats
[379.025767] Subtest dsc-with-formats: SKIP (0.002s)
[379.068516] [063/133] (642s left) gem_lmem_swapping (verify-random)
[379.115674] Subtest verify-random: SKIP (0.000s)
[379.166291] [064/133] (642s left) gem_wait (invalid-buf)
[379.215294] Starting subtest: invalid-buf
[379.218151] Subtest invalid-buf: SUCCESS (0.000s)
[379.432869] [065/133] (642s left) kms_lease (lease-invalid-plane)
[379.524417] Starting subtest: lease-invalid-plane
[379.527286] Starting dynamic subtest: pipe-A-eDP-1
[379.530211] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[379.541423] Starting dynamic subtest: pipe-B-eDP-1
[379.543901] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[379.554316] Starting dynamic subtest: pipe-C-eDP-1
[379.557100] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[379.568059] Starting dynamic subtest: pipe-D-eDP-1
[379.570564] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[379.573305] Subtest lease-invalid-plane: SUCCESS (0.004s)
[379.622284] [066/133] (642s left) gem_exec_schedule (semaphore-codependency)
[379.700847] Starting subtest: semaphore-codependency
[379.707147] Subtest semaphore-codependency: SUCCESS (0.015s)
[380.084100] [067/133] (641s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-pwrite)
[380.192008] Starting subtest: psr-1p-offscreen-pri-indfb-draw-pwrite
[387.238909] Subtest psr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.043s)
[387.400862] [068/133] (634s left) kms_chamelium_frames (vga-frame-dump)
[387.801210] Subtest vga-frame-dump: SKIP (0.000s)
[388.580320] [069/133] (633s left) gem_tiled_pread_basic (basic)
[388.651410] Subtest basic: SKIP (0.000s)
[388.716336] [070/133] (633s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[388.824826] Starting subtest: multiplane-rotation-cropping-bottom
[406.391089] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.560s)
[406.522302] [071/133] (615s left) prime_mmap (test_map_unmap)
[406.586903] Starting subtest: test_map_unmap
[406.589181] Starting dynamic subtest: test_map_unmap-smem
[406.618055] Dynamic subtest test_map_unmap-smem: SUCCESS (0.033s)
[406.620297] Subtest test_map_unmap: SUCCESS (0.034s)
[406.750651] [072/133] (615s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[406.846871] Starting subtest: primary-x-tiled-reflect-x-0
[414.156968] Subtest primary-x-tiled-reflect-x-0: SUCCESS (7.313s)
[415.373163] [073/133] (606s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[415.490947] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[415.496263] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[415.602523] [074/133] (606s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[415.728978] Starting subtest: cursorB-vs-flipA-atomic-transitions
[415.733674] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s)
[415.901048] [075/133] (606s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[416.006647] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[416.011835] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[416.116937] [076/133] (606s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[416.222435] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[416.227807] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[416.345164] [077/133] (605s left) gem_exec_capture (capture)
[416.416628] Starting subtest: capture
[416.418405] Starting dynamic subtest: rcs0-smem
[417.253529] Dynamic subtest rcs0-smem: SUCCESS (0.836s)
[417.265061] Starting dynamic subtest: bcs0-smem
[418.578721] Dynamic subtest bcs0-smem: SUCCESS (1.325s)
[418.589978] Starting dynamic subtest: vcs0-smem
[419.403071] Dynamic subtest vcs0-smem: SUCCESS (0.824s)
[419.414121] Starting dynamic subtest: vcs1-smem
[420.221110] Dynamic subtest vcs1-smem: SUCCESS (0.816s)
[420.233212] Starting dynamic subtest: vecs0-smem
[421.626329] Dynamic subtest vecs0-smem: FAIL (1.334s)
[421.637856] Starting dynamic subtest: ccs0-smem
[422.877428] Dynamic subtest ccs0-smem: SUCCESS (1.322s)
[422.879986] Subtest capture: FAIL (6.461s)
[423.037391] [078/133] (599s left) gem_exec_flush (basic-wb-ro-before-default)
[423.109871] Starting subtest: basic-wb-ro-before-default
[428.585328] Subtest basic-wb-ro-before-default: SUCCESS (5.476s)
[428.795756] [079/133] (593s left) template (a)
[428.856744] Starting subtest: A
[428.859422] Subtest A: SUCCESS (0.000s)
[428.962010] [080/133] (593s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[429.070029] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[429.072705] Starting dynamic subtest: pipe-A-default-mode
[430.212242] Dynamic subtest pipe-A-default-mode: SKIP (1.139s)
[430.218201] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.140s)
[430.379714] [081/133] (592s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu)
[430.475951] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu
[437.310299] Subtest fbcpsr-rgb565-draw-mmap-cpu: SUCCESS (6.837s)
[437.462285] [082/133] (585s left) gem_exec_balancer (busy)
[437.532401] Starting subtest: busy
[439.551117] Subtest busy: SUCCESS (2.016s)
[439.888883] [083/133] (582s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[439.958363] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[439.961267] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[440.078658] [084/133] (582s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[440.135669] Starting subtest: multi-wait-all-for-submit-signaled
[440.138346] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[440.256259] [085/133] (582s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[440.362590] Starting subtest: blocking-absolute-wf_vblank-interruptible
[440.365340] Starting dynamic subtest: A-eDP1
[449.060064] Dynamic subtest A-eDP1: SUCCESS (8.693s)
[449.071433] Starting dynamic subtest: B-eDP1
[457.798363] Dynamic subtest B-eDP1: SUCCESS (8.733s)
[457.815554] Starting dynamic subtest: C-eDP1
[466.514202] Dynamic subtest C-eDP1: SUCCESS (8.711s)
[466.526572] Starting dynamic subtest: D-eDP1
[475.236243] Dynamic subtest D-eDP1: SUCCESS (8.720s)
[475.242190] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.870s)
[476.456942] [086/133] (546s left) gem_lmem_swapping (heavy-verify-random-ccs)
[476.506455] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[476.557613] [087/133] (546s left) kms_prime (d3hot)
[476.643446] Subtest D3hot: SKIP (0.000s)
[476.741575] [088/133] (546s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[476.846228] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[476.851226] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[476.977123] [089/133] (545s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[477.110340] Starting subtest: short-flip-after-cursor-atomic-transitions
[478.077121] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.968s)
[478.889017] [090/133] (543s left) gem_ctx_persistence (heartbeat-many)
[478.957732] Starting subtest: heartbeat-many
[478.962457] Subtest heartbeat-many: SKIP (0.000s)
[479.089555] [091/133] (543s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[479.192585] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[486.528332] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.340s)
[486.673302] [092/133] (536s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[486.776169] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[486.778843] Starting dynamic subtest: pipe-A-eDP-1
[486.807258] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[486.818868] Starting dynamic subtest: pipe-B-eDP-1
[486.846473] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[486.856470] Starting dynamic subtest: pipe-C-eDP-1
[486.884959] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[486.895242] Starting dynamic subtest: pipe-D-eDP-1
[486.924317] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[486.929621] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[488.978007] [093/133] (534s left) kms_dirtyfb (default-dirtyfb-ioctl)
[489.074590] Starting subtest: default-dirtyfb-ioctl
[489.077241] Starting dynamic subtest: A-eDP-1
[490.670354] Dynamic subtest A-eDP-1: SUCCESS (1.595s)
[490.673301] Subtest default-dirtyfb-ioctl: SUCCESS (1.597s)
[491.507488] [094/133] (531s left) syncobj_timeline (wait-for-submit-complex)
[491.566283] Starting subtest: wait-for-submit-complex
[491.626647] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[491.717408] [095/133] (531s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[491.821110] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[491.823208] Starting dynamic subtest: pipe-A-eDP-1
[492.245368] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.425s)
[492.258439] Starting dynamic subtest: pipe-B-eDP-1
[492.282346] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.003s)
[492.292986] Starting dynamic subtest: pipe-C-eDP-1
[492.315986] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.003s)
[492.325655] Starting dynamic subtest: pipe-D-eDP-1
[492.348441] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[492.354240] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.440s)
[494.554244] [096/133] (528s left) api_intel_allocator (reopen-fork)
[494.617712] Starting subtest: reopen-fork
[498.097937] Subtest reopen-fork: SUCCESS (3.483s)
[498.187808] [097/133] (524s left) kms_plane_multiple (2x-tiling-none)
[498.312262] Starting subtest: 2x-tiling-none
[498.318008] Subtest 2x-tiling-none: SKIP (0.000s)
[498.402885] [098/133] (524s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[498.503207] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[498.505937] Starting dynamic subtest: pipe-A
[498.729464] Dynamic subtest pipe-A: SUCCESS (0.229s)
[498.741417] Starting dynamic subtest: pipe-B
[500.026230] Dynamic subtest pipe-B: SUCCESS (1.296s)
[500.036851] Starting dynamic subtest: pipe-C
[501.358428] Dynamic subtest pipe-C: SUCCESS (1.331s)
[501.369678] Starting dynamic subtest: pipe-D
[502.695092] Dynamic subtest pipe-D: SUCCESS (1.336s)
[502.697762] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.195s)
[503.881508] [099/133] (519s left) kms_atomic (atomic-plane-damage)
[503.977111] Starting subtest: atomic-plane-damage
[504.030971] Starting dynamic subtest: pipe-A-eDP-1
[504.594487] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.564s)
[504.596895] Subtest atomic-plane-damage: SUCCESS (0.616s)
[505.396784] [100/133] (517s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[505.500574] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[512.426922] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.928s)
[512.580256] [101/133] (510s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[512.701191] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[512.706050] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[512.825829] [102/133] (510s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[512.944236] Starting subtest: y-tiled-64bpp-rotate-180
[512.949325] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[513.072235] [103/133] (510s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[513.172322] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[513.175097] Starting dynamic subtest: pipe-A-eDP-1
[513.186041] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[513.197671] Starting dynamic subtest: pipe-B-eDP-1
[513.208212] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[513.219443] Starting dynamic subtest: pipe-C-eDP-1
[513.230987] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[513.242891] Starting dynamic subtest: pipe-D-eDP-1
[513.253399] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[513.258416] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[515.489841] [104/133] (507s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[515.606581] Starting subtest: yf-tiled-32bpp-rotate-180
[515.611637] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[515.738152] [105/133] (507s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[515.849182] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[515.854205] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[515.979000] [106/133] (507s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[516.081026] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[517.124912] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.045s)
[517.284471] [107/133] (506s left) gem_exec_flush (basic-uc-ro-default)
[517.360154] Starting subtest: basic-uc-ro-default
[522.826597] Subtest basic-uc-ro-default: SUCCESS (5.466s)
[523.032427] [108/133] (500s left) kms_color (ctm-green-to-red)
[523.139410] Starting subtest: ctm-green-to-red
[523.141884] Starting dynamic subtest: pipe-A-eDP-1
[523.802113] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.664s)
[523.814115] Starting dynamic subtest: pipe-B-eDP-1
[525.150842] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.347s)
[525.173357] Starting dynamic subtest: pipe-C-eDP-1
[526.509139] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.356s)
[526.520128] Starting dynamic subtest: pipe-D-eDP-1
[527.878017] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.367s)
[527.880335] Subtest ctm-green-to-red: SUCCESS (4.737s)
[528.704151] [109/133] (494s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[528.771437] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all
[528.856752] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.006s)
[528.899975] [110/133] (494s left) syncobj_wait (signal)
[528.965589] Starting subtest: signal
[528.968302] Subtest signal: SUCCESS (0.000s)
[529.090639] [111/133] (494s left) syncobj_wait (wait-all-for-submit-complex)
[529.151866] Starting subtest: wait-all-for-submit-complex
[529.367197] Subtest wait-all-for-submit-complex: SUCCESS (0.215s)
[529.459144] [112/133] (494s left) kms_flip (flip-vs-panning-vs-hang)
[529.555771] Starting subtest: flip-vs-panning-vs-hang
[529.558204] Starting dynamic subtest: A-eDP1
[582.026248] Dynamic subtest A-eDP1: SUCCESS (52.462s)
[582.038757] Starting dynamic subtest: D-eDP1
[632.017137] Dynamic subtest D-eDP1: SUCCESS (49.987s)
[632.020181] Subtest flip-vs-panning-vs-hang: SUCCESS (102.453s)
[633.276629] [113/133] (390s left) kms_addfb_basic (bad-pitch-0)
[633.339407] Starting subtest: bad-pitch-0
[633.342332] Subtest bad-pitch-0: SUCCESS (0.000s)
[633.494062] [114/133] (390s left) gem_userptr_blits (access-control)
[633.583346] Starting subtest: access-control
[633.588410] Subtest access-control: SKIP (0.000s)
[633.728665] [115/133] (390s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[633.831553] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[633.834051] Starting dynamic subtest: pipe-A-eDP-1
[633.899705] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[633.915030] Starting dynamic subtest: pipe-B-eDP-1
[633.980298] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[633.996144] Starting dynamic subtest: pipe-C-eDP-1
[634.066128] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[634.078685] Starting dynamic subtest: pipe-D-eDP-1
[634.145708] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[634.150896] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.009s)
[636.047967] [116/133] (387s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[636.155069] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[636.160372] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[636.281410] [117/133] (387s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[636.380297] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[643.023838] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.646s)
[643.169332] [118/133] (380s left) gem_softpin (noreloc)
[643.227726] Starting subtest: noreloc
[648.638169] Subtest noreloc: SUCCESS (5.408s)
[648.798909] [119/133] (375s left) kms_addfb_basic (bad-pitch-999)
[648.861321] Starting subtest: bad-pitch-999
[648.864149] Subtest bad-pitch-999: SUCCESS (0.000s)
[649.026908] [120/133] (375s left) gem_ctx_create (basic-files)
[649.103179] Starting subtest: basic-files
[651.112599] Subtest basic-files: SUCCESS (2.010s)
[652.579828] [121/133] (371s left) gem_mmap_wc (write-prefaulted)
[652.648305] Subtest write-prefaulted: SKIP (0.000s)
[652.717889] [122/133] (371s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[652.779273] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[652.782257] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[652.889257] [123/133] (371s left) perf_pmu (idle)
[652.935420] Starting subtest: idle
[652.938338] Starting dynamic subtest: rcs0
[653.495218] Dynamic subtest rcs0: SUCCESS (0.558s)
[653.507511] Starting dynamic subtest: bcs0
[654.028434] Dynamic subtest bcs0: SUCCESS (0.526s)
[654.040043] Starting dynamic subtest: vcs0
[654.546430] Dynamic subtest vcs0: SUCCESS (0.519s)
[654.557454] Starting dynamic subtest: vcs1
[655.074850] Dynamic subtest vcs1: SUCCESS (0.526s)
[655.086227] Starting dynamic subtest: vecs0
[655.602270] Dynamic subtest vecs0: SUCCESS (0.525s)
[655.614588] Starting dynamic subtest: ccs0
[656.133954] Dynamic subtest ccs0: SUCCESS (0.528s)
[656.136826] Subtest idle: SUCCESS (3.199s)
[656.253181] [124/133] (368s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[656.360744] Starting subtest: yf-tiled-addfb-size-overflow
[656.366002] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[656.468454] [125/133] (367s left) gem_render_copy_redux (flink)
[656.531866] Starting subtest: flink
[657.287988] Subtest flink: SUCCESS (0.757s)
[657.445062] [126/133] (367s left) gem_busy (semaphore)
[657.644745] Subtest semaphore: SKIP (0.000s)
[657.873753] [127/133] (366s left) i915_pm_freq_api (freq-reset)
[657.949162] Starting subtest: freq-reset
[657.952031] Starting dynamic subtest: gt0
[658.146088] Dynamic subtest gt0: SUCCESS (0.194s)
[658.157474] Starting dynamic subtest: gt1
[658.317768] Dynamic subtest gt1: SUCCESS (0.172s)
[658.320763] Subtest freq-reset: SUCCESS (0.368s)
[658.405710] [128/133] (366s left) gem_ringfill (engines-basic)
[664.549685] Starting subtest: engines-basic
[664.552432] Starting dynamic subtest: rcs0
[664.631677] Dynamic subtest rcs0: SUCCESS (0.081s)
[664.645132] Starting dynamic subtest: bcs0
[664.680231] Dynamic subtest bcs0: SUCCESS (0.046s)
[664.693221] Starting dynamic subtest: vcs0
[664.723283] Dynamic subtest vcs0: SUCCESS (0.041s)
[664.735599] Starting dynamic subtest: vcs1
[664.767276] Dynamic subtest vcs1: SUCCESS (0.043s)
[664.779432] Starting dynamic subtest: vecs0
[664.810248] Dynamic subtest vecs0: SUCCESS (0.041s)
[664.822030] Starting dynamic subtest: ccs0
[664.856228] Dynamic subtest ccs0: SUCCESS (0.044s)
[664.859048] Subtest engines-basic: SUCCESS (0.308s)
[664.947956] [129/133] (359s left) kms_pm_rpm (cursor-dpms)
[666.680776] Starting subtest: cursor-dpms
[666.686251] Subtest cursor-dpms: SKIP (0.000s)
[667.218483] [130/133] (357s left) kms_cursor_crc (cursor-sliding-512x512)
[667.503838] Starting subtest: cursor-sliding-512x512
[667.509350] Subtest cursor-sliding-512x512: SKIP (0.001s)
[667.700293] [131/133] (356s left) syncobj_timeline (etime-multi-wait-submitted)
[667.769254] Starting subtest: etime-multi-wait-submitted
[667.877832] Subtest etime-multi-wait-submitted: SUCCESS (0.107s)
[667.973561] [132/133] (356s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[668.083360] Starting subtest: fbc-rgb565-draw-mmap-wc
[672.151992] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (4.073s)
[673.287716] [133/133] (351s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[673.348150] Starting subtest: multi-wait-all-available-submitted-signaled
[673.351273] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s)
[673.469116] Closing watchdogs
results: parsing output: 0/ for test: kms_psr2_sf
results: parsing output: 1/ for test: kms_ccs
results: parsing output: 2/ for test: kms_sequence
results: parsing output: 3/ for test: i915_query
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: kms_flip
results: parsing output: 6/ for test: gem_mmap_offset
results: parsing output: 7/ for test: kms_plane_scaling
results: parsing output: 8/ for test: kms_hdr
results: parsing output: 9/ for test: gem_exec_gttfill
results: parsing output: 10/ for test: kms_flip
results: parsing output: 11/ for test: gem_exec_reloc
results: parsing output: 12/ for test: kms_cursor_legacy
results: parsing output: 13/ for test: gen3_render_mixed_blits
results: parsing output: 14/ for test: api_intel_bb
results: parsing output: 15/ for test: kms_pipe_crc_basic
results: parsing output: 16/ for test: gem_ctx_isolation
results: parsing output: 17/ for test: kms_content_protection
results: parsing output: 18/ for test: gem_mmap_gtt
results: parsing output: 19/ for test: gem_bad_reloc
results: parsing output: 20/ for test: syncobj_timeline
results: parsing output: 21/ for test: gen7_exec_parse
results: parsing output: 22/ for test: gem_eio
results: parsing output: 23/ for test: gem_exec_schedule
results: parsing output: 24/ for test: gem_exec_fence
results: parsing output: 25/ for test: gem_exec_reloc
results: parsing output: 26/ for test: kms_psr
results: parsing output: 27/ for test: kms_psr2_sf
results: parsing output: 28/ for test: kms_getfb
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: gem_softpin
results: parsing output: 31/ for test: syncobj_timeline
results: parsing output: 32/ for test: kms_psr
results: parsing output: 33/ for test: gem_mmap_gtt
results: parsing output: 34/ for test: kms_cursor_crc
results: parsing output: 35/ for test: kms_busy
results: parsing output: 36/ for test: kms_psr2_sf
results: parsing output: 37/ for test: syncobj_basic
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: prime_mmap
results: parsing output: 40/ for test: i915_drm_fdinfo
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: i915_pm_rpm
results: parsing output: 43/ for test: gem_exec_store
results: parsing output: 44/ for test: gem_eio
results: parsing output: 45/ for test: kms_cursor_legacy
results: parsing output: 46/ for test: kms_flip_scaled_crc
results: parsing output: 47/ for test: kms_cursor_crc
results: parsing output: 48/ for test: core_hotunplug
results: parsing output: 49/ for test: kms_chamelium_color
results: parsing output: 50/ for test: gem_ctx_exec
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: gem_eio
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gem_pxp
results: parsing output: 55/ for test: kms_psr
results: parsing output: 56/ for test: kms_psr
results: parsing output: 57/ for test: kms_vrr
results: parsing output: 58/ for test: intel_hwmon
results: parsing output: 59/ for test: kms_vblank
results: parsing output: 60/ for test: kms_plane
results: parsing output: 61/ for test: kms_dsc
results: parsing output: 62/ for test: gem_lmem_swapping
results: parsing output: 63/ for test: gem_wait
results: parsing output: 64/ for test: kms_lease
results: parsing output: 65/ for test: gem_exec_schedule
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_chamelium_frames
results: parsing output: 68/ for test: gem_tiled_pread_basic
results: parsing output: 69/ for test: kms_rotation_crc
results: parsing output: 70/ for test: prime_mmap
results: parsing output: 71/ for test: kms_rotation_crc
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_cursor_legacy
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: gem_exec_capture
results: parsing output: 77/ for test: gem_exec_flush
results: parsing output: 78/ for test: template
results: parsing output: 79/ for test: kms_flip_scaled_crc
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: gem_exec_balancer
results: parsing output: 82/ for test: syncobj_wait
results: parsing output: 83/ for test: syncobj_wait
results: parsing output: 84/ for test: kms_flip
results: parsing output: 85/ for test: gem_lmem_swapping
results: parsing output: 86/ for test: kms_prime
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_cursor_legacy
results: parsing output: 89/ for test: gem_ctx_persistence
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_ccs
results: parsing output: 92/ for test: kms_dirtyfb
results: parsing output: 93/ for test: syncobj_timeline
results: parsing output: 94/ for test: kms_ccs
results: parsing output: 95/ for test: api_intel_allocator
results: parsing output: 96/ for test: kms_plane_multiple
results: parsing output: 97/ for test: kms_plane_scaling
results: parsing output: 98/ for test: kms_atomic
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: kms_ccs
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: gem_exec_flush
results: parsing output: 107/ for test: kms_color
results: parsing output: 108/ for test: sriov_basic
results: parsing output: 109/ for test: syncobj_wait
results: parsing output: 110/ for test: syncobj_wait
results: parsing output: 111/ for test: kms_flip
results: parsing output: 112/ for test: kms_addfb_basic
results: parsing output: 113/ for test: gem_userptr_blits
results: parsing output: 114/ for test: kms_ccs
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: gem_softpin
results: parsing output: 118/ for test: kms_addfb_basic
results: parsing output: 119/ for test: gem_ctx_create
results: parsing output: 120/ for test: gem_mmap_wc
results: parsing output: 121/ for test: syncobj_timeline
results: parsing output: 122/ for test: perf_pmu
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: gem_render_copy_redux
results: parsing output: 125/ for test: gem_busy
results: parsing output: 126/ for test: i915_pm_freq_api
results: parsing output: 127/ for test: gem_ringfill
results: parsing output: 128/ for test: kms_pm_rpm
results: parsing output: 129/ for test: kms_cursor_crc
results: parsing output: 130/ for test: syncobj_timeline
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: syncobj_timeline
Done.