[59.766753] Initializing watchdogs
[59.766813]   /dev/watchdog0
[59.780956] [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]
[59.785421] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.787652] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.789368] [001/133] (960s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf)
[59.901724] Starting subtest: fbc-psr2-overlay-plane-move-continuous-sf
[59.902682] Starting dynamic subtest: pipe-A-eDP-1
[60.026846] Dynamic subtest pipe-A-eDP-1: SKIP (0.125s)
[60.033713] Starting dynamic subtest: pipe-B-eDP-1
[61.174221] Dynamic subtest pipe-B-eDP-1: SKIP (1.153s)
[61.175930] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (1.280s)
[62.460346] [002/133] (957s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[62.560384] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[62.561573] Starting dynamic subtest: pipe-A-eDP-1
[62.572096] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[62.579273] Starting dynamic subtest: pipe-B-eDP-1
[62.587659] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[62.593157] Starting dynamic subtest: pipe-C-eDP-1
[62.601636] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[62.607775] Starting dynamic subtest: pipe-D-eDP-1
[62.616175] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[62.617828] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[64.810358] [003/133] (955s left) kms_sequence (queue-busy)
[64.909825] Starting subtest: queue-busy
[64.910910] Starting dynamic subtest: pipe-A-eDP-1
[66.837870] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.934s)
[66.845990] Starting dynamic subtest: pipe-B-eDP-1
[69.386827] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.554s)
[69.396849] Starting dynamic subtest: pipe-C-eDP-1
[71.988179] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.604s)
[71.994826] Starting dynamic subtest: pipe-D-eDP-1
[74.529170] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.543s)
[74.530100] Subtest queue-busy: SUCCESS (9.639s)
[75.406703] [004/133] (944s left) i915_query (test-query-geometry-subslices)
[75.465098] Starting subtest: test-query-geometry-subslices
[75.466050] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[75.576051] [005/133] (944s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[75.673263] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[76.740082] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.068s)
[76.898197] [006/133] (943s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[77.000962] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[77.011744] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.011s)
[77.094241] [007/133] (943s left) gem_mmap_offset (mmap-unmap)
[77.149761] Starting subtest: mmap-unmap
[77.150676] Starting dynamic subtest: smem0
[101.196709] Dynamic subtest smem0: SUCCESS (23.999s)
[101.197838] Subtest mmap-unmap: SUCCESS (24.000s)
[101.299891] [008/133] (919s left) kms_plane_scaling (planes-scaler-unity-scaling)
[101.403796] Starting subtest: planes-scaler-unity-scaling
[101.404581] Starting dynamic subtest: pipe-A
[101.466936] Dynamic subtest pipe-A: SUCCESS (0.064s)
[101.474992] Starting dynamic subtest: pipe-B
[102.625405] Dynamic subtest pipe-B: SUCCESS (1.157s)
[102.633023] Starting dynamic subtest: pipe-C
[103.731749] Dynamic subtest pipe-C: SUCCESS (1.106s)
[103.738318] Starting dynamic subtest: pipe-D
[104.871725] Dynamic subtest pipe-D: SUCCESS (1.140s)
[104.872736] Subtest planes-scaler-unity-scaling: SUCCESS (3.468s)
[106.040397] [009/133] (914s left) kms_hdr (static-toggle)
[106.139477] Starting subtest: static-toggle
[106.142248] Subtest static-toggle: SKIP (0.000s)
[106.243494] [010/133] (914s left) gem_exec_gttfill (basic)
[106.313366] Starting subtest: basic
[108.792966] Subtest basic: SUCCESS (2.478s)
[108.981909] [011/133] (911s left) kms_flip (flip-vs-rmfb-interruptible)
[109.121638] Starting subtest: flip-vs-rmfb-interruptible
[109.123957] Starting dynamic subtest: A-eDP1
[117.821373] Dynamic subtest A-eDP1: SUCCESS (8.697s)
[117.829398] Starting dynamic subtest: B-eDP1
[126.453361] Dynamic subtest B-eDP1: SUCCESS (8.631s)
[126.461642] Starting dynamic subtest: C-eDP1
[135.070093] Dynamic subtest C-eDP1: SUCCESS (8.615s)
[135.079696] Starting dynamic subtest: D-eDP1
[143.700840] Dynamic subtest D-eDP1: SUCCESS (8.629s)
[143.703263] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.580s)
[144.882079] [012/133] (875s left) gem_exec_reloc (basic-active)
[144.939666] Subtest basic-active: SKIP (0.000s)
[145.009872] [013/133] (875s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[145.124860] Starting subtest: short-flip-before-cursor-toggle
[146.039256] Subtest short-flip-before-cursor-toggle: SUCCESS (0.913s)
[146.914921] [014/133] (873s left) gen3_render_mixed_blits
[147.044375] [015/133] (873s left) api_intel_bb (render-ccs)
[147.104123] Starting subtest: render-ccs
[147.466629] Subtest render-ccs: SUCCESS (0.354s)
[147.547791] [016/133] (873s left) kms_pipe_crc_basic (suspend-read-crc)
[147.642498] Starting subtest: suspend-read-crc
[147.643396] Starting dynamic subtest: pipe-A-eDP-1
[165.650924] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.073s)
[165.667211] Starting dynamic subtest: pipe-B-eDP-1
[184.659755] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.477s)
[184.670675] Starting dynamic subtest: pipe-C-eDP-1
[203.613287] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.377s)
[203.620443] Starting dynamic subtest: pipe-D-eDP-1
[222.619834] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.404s)
[222.620749] Subtest suspend-read-crc: SUCCESS (13.338s)
[231.477249] [017/133] (797s left) gem_ctx_isolation (dirty-switch)
[231.540063] Starting subtest: dirty-switch
[231.540952] Starting dynamic subtest: rcs0
[231.794448] Dynamic subtest rcs0: SUCCESS (0.256s)
[231.803389] Starting dynamic subtest: bcs0
[232.069251] Dynamic subtest bcs0: SUCCESS (0.283s)
[232.076917] Starting dynamic subtest: vcs0
[232.327414] Dynamic subtest vcs0: SUCCESS (0.266s)
[232.334969] Starting dynamic subtest: vcs1
[233.782949] Dynamic subtest vcs1: SUCCESS (1.501s)
[233.791928] Starting dynamic subtest: vecs0
[235.761398] Dynamic subtest vecs0: SUCCESS (2.027s)
[235.768369] Starting dynamic subtest: ccs0
[237.781367] Dynamic subtest ccs0: SUCCESS (2.058s)
[237.783022] Subtest dirty-switch: SUCCESS (6.396s)
[238.044934] [018/133] (790s left) kms_content_protection (dp-mst-lic-type-1)
[238.183158] Starting subtest: dp-mst-lic-type-1
[238.185201] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[238.331082] [019/133] (790s left) gem_mmap_gtt (big-bo-tiledy)
[238.383236] Subtest big-bo-tiledY: SKIP (0.000s)
[238.430475] [020/133] (790s left) gem_bad_reloc (negative-reloc-bltcopy)
[238.489645] Subtest negative-reloc-bltcopy: SKIP (0.000s)
[238.553481] [021/133] (790s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[238.615060] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[238.721285] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.106s)
[238.809587] [022/133] (790s left) gen7_exec_parse (basic-rejected)
[238.866226] Subtest basic-rejected: SKIP (0.000s)
[238.928946] [023/133] (790s left) gem_eio (kms)
[239.213268] Starting subtest: kms
[257.777872] Subtest kms: SUCCESS (18.656s)
[258.950040] [FACT gem_eio (kms)] new: kernel.kmod_is_loaded.vgem: true
[258.951800] [024/133] (770s left) gem_exec_schedule (preempt-queue-contexts)
[259.016557] Subtest preempt-queue-contexts: SKIP (0.000s)
[259.320465] [025/133] (769s left) gem_exec_fence (invalid-timeline-fence-array)
[259.839014] Starting subtest: invalid-timeline-fence-array
[259.840033] Subtest invalid-timeline-fence-array: SUCCESS (0.006s)
[261.623790] [026/133] (767s left) gem_exec_reloc (basic-cpu-active)
[261.680389] Subtest basic-cpu-active: SKIP (0.000s)
[261.756625] [027/133] (767s left) kms_psr (fbc-psr2-dpms)
[261.857893] Starting subtest: fbc-psr2-dpms
[261.858787] Starting dynamic subtest: eDP-1
[261.860497] Dynamic subtest eDP-1: SKIP (0.000s)
[261.862161] Subtest fbc-psr2-dpms: SKIP (0.001s)
[261.940994] [028/133] (767s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[262.032270] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[262.033132] Starting dynamic subtest: pipe-A-eDP-1
[273.356351] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.320s)
[273.364041] Starting dynamic subtest: pipe-B-eDP-1
[285.354205] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.995s)
[285.355106] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (23.318s)
[286.239461] [029/133] (743s left) kms_getfb (getfb-addfb-different-handles)
[286.330473] Starting subtest: getfb-addfb-different-handles
[286.331437] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[286.461082] [030/133] (742s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[286.565167] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[286.566799] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[286.692049] [031/133] (742s left) gem_softpin (evict-prime)
[286.751973] Starting subtest: evict-prime
[286.752984] Starting dynamic subtest: rcs0
[287.919424] Dynamic subtest rcs0: SUCCESS (1.167s)
[287.936093] Starting dynamic subtest: bcs0
[289.086528] Dynamic subtest bcs0: SUCCESS (1.160s)
[289.100228] Starting dynamic subtest: vcs0
[290.554846] Dynamic subtest vcs0: SUCCESS (1.462s)
[290.563705] Starting dynamic subtest: vcs1
[292.549786] Dynamic subtest vcs1: SUCCESS (1.993s)
[292.558722] Starting dynamic subtest: vecs0
[294.529935] Dynamic subtest vecs0: SUCCESS (1.978s)
[294.540900] Starting dynamic subtest: ccs0
[295.676267] Dynamic subtest ccs0: SUCCESS (1.153s)
[295.688637] Starting dynamic subtest: all
[297.533841] Dynamic subtest all: SUCCESS (1.847s)
[297.535179] Subtest evict-prime: SUCCESS (10.776s)
[297.617901] [032/133] (731s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[297.675816] Starting subtest: single-wait-for-submit-available-signaled
[297.676723] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[297.796379] [033/133] (731s left) kms_psr (psr2-primary-render)
[297.894828] Starting subtest: psr2-primary-render
[297.895784] Starting dynamic subtest: eDP-1
[299.598990] Dynamic subtest eDP-1: SUCCESS (1.704s)
[299.599884] Subtest psr2-primary-render: SUCCESS (1.705s)
[300.477138] [034/133] (728s left) gem_mmap_gtt (basic-small-copy-odd)
[300.537269] Subtest basic-small-copy-odd: SKIP (0.000s)
[300.598012] [035/133] (728s left) kms_cursor_crc (cursor-onscreen-128x42)
[300.824815] Starting subtest: cursor-onscreen-128x42
[300.875027] Subtest cursor-onscreen-128x42: SKIP (0.050s)
[301.122272] [036/133] (728s left) kms_busy (extended-pageflip-hang-oldfb)
[301.233831] Starting subtest: extended-pageflip-hang-oldfb
[301.235973] Starting dynamic subtest: pipe-A
[301.668617] Dynamic subtest pipe-A: SUCCESS (0.432s)
[301.677856] Starting dynamic subtest: pipe-D
[302.806534] Dynamic subtest pipe-D: SUCCESS (1.136s)
[302.807385] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.574s)
[303.648584] [037/133] (725s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[303.740001] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf
[303.741634] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[303.823030] [038/133] (725s left) syncobj_basic (bad-destroy)
[303.882743] Starting subtest: bad-destroy
[303.883578] Subtest bad-destroy: SUCCESS (0.000s)
[304.005002] [039/133] (725s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[304.099541] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[311.042450] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.945s)
[311.187767] [040/133] (718s left) prime_mmap (test_forked_cpu_write)
[311.242470] Starting subtest: test_forked_cpu_write
[311.243433] Starting dynamic subtest: test_forked_cpu_write-smem
[311.248944] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.007s)
[311.249876] Subtest test_forked_cpu_write: SUCCESS (0.008s)
[311.365883] [041/133] (718s left) i915_drm_fdinfo (most-busy-idle-check-all)
[311.407714] Starting subtest: most-busy-idle-check-all
[311.408643] Starting dynamic subtest: rcs0
[311.412722] Dynamic subtest rcs0: SKIP (0.004s)
[311.420300] Starting dynamic subtest: bcs0
[311.422012] Dynamic subtest bcs0: SKIP (0.000s)
[311.429186] Starting dynamic subtest: vcs0
[311.430927] Dynamic subtest vcs0: SKIP (0.000s)
[311.437850] Starting dynamic subtest: vcs1
[311.439688] Dynamic subtest vcs1: SKIP (0.000s)
[311.446615] Starting dynamic subtest: vecs0
[311.448263] Dynamic subtest vecs0: SKIP (0.000s)
[311.455279] Starting dynamic subtest: ccs0
[311.456992] Dynamic subtest ccs0: SKIP (0.000s)
[311.458859] Subtest most-busy-idle-check-all: SKIP (0.009s)
[311.487082] [042/133] (718s left) kms_big_fb (linear-16bpp-rotate-90)
[311.627865] Starting subtest: linear-16bpp-rotate-90
[311.646961] Subtest linear-16bpp-rotate-90: SKIP (0.019s)
[311.803983] [043/133] (717s left) i915_pm_rpm (system-suspend-devices)
[313.749935] Starting subtest: system-suspend-devices
[321.416468] Subtest system-suspend-devices: SUCCESS (7.672s)
[327.872627] [044/133] (707s left) gem_exec_store (cachelines)
[327.946882] Starting subtest: cachelines
[327.947806] Starting dynamic subtest: rcs0
[328.072398] Dynamic subtest rcs0: SUCCESS (0.124s)
[328.089257] Starting dynamic subtest: bcs0
[328.146545] Dynamic subtest bcs0: SUCCESS (0.072s)
[328.158845] Starting dynamic subtest: vcs0
[328.213151] Dynamic subtest vcs0: SUCCESS (0.065s)
[328.224257] Starting dynamic subtest: vcs1
[328.279277] Dynamic subtest vcs1: SUCCESS (0.064s)
[328.290420] Starting dynamic subtest: vecs0
[328.340528] Dynamic subtest vecs0: SUCCESS (0.059s)
[328.352217] Starting dynamic subtest: ccs0
[328.411440] Dynamic subtest ccs0: SUCCESS (0.069s)
[328.412726] Subtest cachelines: SUCCESS (0.465s)
[328.603126] [045/133] (707s left) gem_eio (wait-10ms)
[328.854204] Starting subtest: wait-10ms
[329.261082] Subtest wait-10ms: SUCCESS (0.408s)
[329.429034] [046/133] (706s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[329.552133] Starting subtest: basic-busy-flip-before-cursor-atomic
[329.554622] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[329.711591] [047/133] (706s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[329.799832] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[329.801617] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.000s)
[329.894045] [048/133] (706s left) kms_cursor_crc (cursor-sliding-128x128)
[330.100586] Starting subtest: cursor-sliding-128x128
[330.108163] Starting dynamic subtest: pipe-A-eDP-1
[333.395154] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.286s)
[333.424260] Starting dynamic subtest: pipe-D-eDP-1
[337.313085] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.895s)
[337.313966] Subtest cursor-sliding-128x128: SUCCESS (7.212s)
[338.143033] [049/133] (697s left) core_hotunplug (unbind-rebind)
[338.236843] Starting subtest: unbind-rebind
[342.761081] Subtest unbind-rebind: SUCCESS (4.525s)
[342.808064] [050/133] (693s left) kms_chamelium_color (gamma)
[344.489761] Subtest gamma: SKIP (0.000s)
[344.554101] [051/133] (691s left) gem_ctx_exec (basic-close-race)
[344.606809] Starting subtest: basic-close-race
[350.204882] Subtest basic-close-race: SUCCESS (5.553s)
[350.326586] [052/133] (685s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[350.430181] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[350.431886] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[350.558416] [053/133] (685s left) gem_eio (in-flight-external)
[350.768594] Starting subtest: in-flight-external
[352.606368] Subtest in-flight-external: SUCCESS (1.837s)
[352.777591] [054/133] (683s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[352.884716] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[352.886422] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[353.022065] [055/133] (683s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[353.142250] Starting subtest: verify-pxp-execution-after-suspend-resume
[360.203695] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.065s)
[369.390368] [056/133] (675s left) kms_psr (pr-basic)
[369.484514] Starting subtest: pr-basic
[369.486266] Subtest pr-basic: SKIP (0.000s)
[369.566685] [057/133] (675s left) kms_psr (fbc-psr-cursor-mmap-cpu)
[369.669547] Starting subtest: fbc-psr-cursor-mmap-cpu
[369.670374] Starting dynamic subtest: eDP-1
[369.672051] Dynamic subtest eDP-1: SKIP (0.000s)
[369.673853] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.001s)
[369.751284] [058/133] (675s left) kms_vrr (flip-suspend)
[369.859677] Starting subtest: flip-suspend
[369.864240] Subtest flip-suspend: SKIP (0.000s)
[369.941160] [059/133] (675s left) intel_hwmon (hwmon-write)
[370.000597] Subtest hwmon-write: SKIP (0.000s)
[370.071114] [060/133] (675s left) kms_vblank (ts-continuation-suspend)
[370.173992] Starting subtest: ts-continuation-suspend
[370.174914] Starting dynamic subtest: pipe-A-eDP-1
[387.036093] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.015s)
[387.046358] Starting dynamic subtest: pipe-D-eDP-1
[405.037746] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.596s)
[405.038549] Subtest ts-continuation-suspend: SUCCESS (4.615s)
[410.894994] [061/133] (639s left) kms_plane (pixel-format-yf-tiled-ccs-modifier-source-clamping)
[410.992423] Starting subtest: pixel-format-yf-tiled-ccs-modifier-source-clamping
[410.994433] Subtest pixel-format-yf-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[411.115707] [062/133] (639s left) kms_dsc (dsc-with-formats)
[411.221954] Starting subtest: dsc-with-formats
[411.237983] Subtest dsc-with-formats: SKIP (0.001s)
[411.313765] [063/133] (639s left) gem_lmem_swapping (verify-random)
[411.353744] Subtest verify-random: SKIP (0.000s)
[411.396871] [064/133] (639s left) gem_wait (invalid-buf)
[411.445740] Starting subtest: invalid-buf
[411.447104] Subtest invalid-buf: SUCCESS (0.000s)
[411.719033] [065/133] (639s left) kms_lease (lease-invalid-plane)
[411.813073] Starting subtest: lease-invalid-plane
[411.813950] Starting dynamic subtest: pipe-A-eDP-1
[411.814777] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[411.825270] Starting dynamic subtest: pipe-B-eDP-1
[411.826268] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[411.834551] Starting dynamic subtest: pipe-C-eDP-1
[411.835557] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[411.843921] Starting dynamic subtest: pipe-D-eDP-1
[411.844749] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[411.845579] Subtest lease-invalid-plane: SUCCESS (0.004s)
[411.909897] [066/133] (638s left) gem_exec_schedule (semaphore-codependency)
[411.983935] Starting subtest: semaphore-codependency
[411.997078] Subtest semaphore-codependency: SUCCESS (0.013s)
[412.357481] [067/133] (638s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-pwrite)
[412.455095] Starting subtest: psr-1p-offscreen-pri-indfb-draw-pwrite
[419.556692] Subtest psr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.102s)
[419.676986] [068/133] (631s left) kms_chamelium_frames (vga-frame-dump)
[420.072311] Subtest vga-frame-dump: SKIP (0.000s)
[420.906334] [069/133] (629s left) gem_tiled_pread_basic (basic)
[420.958964] Subtest basic: SKIP (0.000s)
[421.045176] [070/133] (629s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[421.134853] Starting subtest: multiplane-rotation-cropping-bottom
[438.295544] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.393s)
[438.432256] [071/133] (612s left) prime_mmap (test_map_unmap)
[438.481571] Starting subtest: test_map_unmap
[438.482371] Starting dynamic subtest: test_map_unmap-smem
[438.513652] Dynamic subtest test_map_unmap-smem: SUCCESS (0.032s)
[438.514618] Subtest test_map_unmap: SUCCESS (0.033s)
[438.620726] [072/133] (612s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[438.712966] Starting subtest: primary-x-tiled-reflect-x-0
[445.864778] Subtest primary-x-tiled-reflect-x-0: SUCCESS (7.170s)
[447.030133] [073/133] (604s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[447.117281] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[447.119131] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[447.239456] [074/133] (603s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[447.349975] Starting subtest: cursorB-vs-flipA-atomic-transitions
[447.352628] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s)
[447.503320] [075/133] (603s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[447.602010] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[447.603742] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[447.724454] [076/133] (603s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[447.816181] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[447.818054] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[447.925429] [077/133] (603s left) gem_exec_capture (capture)
[447.989494] Starting subtest: capture
[447.990488] Starting dynamic subtest: rcs0-smem
[448.827398] Dynamic subtest rcs0-smem: SUCCESS (0.839s)
[448.835566] Starting dynamic subtest: bcs0-smem
[449.658517] Dynamic subtest bcs0-smem: SUCCESS (0.832s)
[449.668051] Starting dynamic subtest: vcs0-smem
[450.480244] Dynamic subtest vcs0-smem: SUCCESS (0.821s)
[450.488298] Starting dynamic subtest: vcs1-smem
[451.810259] Dynamic subtest vcs1-smem: SUCCESS (1.330s)
[451.821469] Starting dynamic subtest: vecs0-smem
[452.652064] Dynamic subtest vecs0-smem: FAIL (0.820s)
[452.659959] Starting dynamic subtest: ccs0-smem
[453.954452] Dynamic subtest ccs0-smem: SUCCESS (1.324s)
[453.955438] Subtest capture: FAIL (5.973s)
[454.107573] [078/133] (597s left) gem_exec_flush (basic-wb-ro-before-default)
[454.177434] Starting subtest: basic-wb-ro-before-default
[459.647216] Subtest basic-wb-ro-before-default: SUCCESS (5.464s)
[459.841349] [079/133] (591s left) template (a)
[459.894955] Starting subtest: A
[459.895892] Subtest A: SUCCESS (0.000s)
[460.018514] [080/133] (591s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[460.118699] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[460.119610] Starting dynamic subtest: pipe-A-default-mode
[461.278658] Dynamic subtest pipe-A-default-mode: SKIP (1.158s)
[461.280494] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.159s)
[461.466533] [081/133] (589s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu)
[461.563047] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu
[468.420325] Subtest fbcpsr-rgb565-draw-mmap-cpu: SUCCESS (6.855s)
[468.576975] [082/133] (582s left) gem_exec_balancer (busy)
[468.640377] Starting subtest: busy
[470.809114] Subtest busy: SUCCESS (2.158s)
[471.131514] [083/133] (580s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[471.176727] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[471.177703] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[471.299244] [084/133] (580s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[471.349419] Starting subtest: multi-wait-all-for-submit-signaled
[471.350331] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[471.455064] [085/133] (580s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[471.548427] Starting subtest: blocking-absolute-wf_vblank-interruptible
[471.550674] Starting dynamic subtest: A-eDP1
[480.244357] Dynamic subtest A-eDP1: SUCCESS (8.693s)
[480.255417] Starting dynamic subtest: B-eDP1
[488.997217] Dynamic subtest B-eDP1: SUCCESS (8.727s)
[489.007321] Starting dynamic subtest: C-eDP1
[497.730470] Dynamic subtest C-eDP1: SUCCESS (8.719s)
[497.741326] Starting dynamic subtest: D-eDP1
[506.457721] Dynamic subtest D-eDP1: SUCCESS (8.728s)
[506.458599] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.879s)
[507.664527] [086/133] (543s left) gem_lmem_swapping (heavy-verify-random-ccs)
[507.702128] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[507.747576] [087/133] (543s left) kms_prime (d3hot)
[507.826856] Subtest D3hot: SKIP (0.000s)
[507.940033] [088/133] (543s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[508.038127] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[508.039937] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[508.188234] [089/133] (543s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[508.304128] Starting subtest: short-flip-after-cursor-atomic-transitions
[509.264297] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.959s)
[510.080505] [090/133] (541s left) gem_ctx_persistence (heartbeat-many)
[510.145492] Starting subtest: heartbeat-many
[510.147333] Subtest heartbeat-many: SKIP (0.000s)
[510.268737] [091/133] (541s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[510.366628] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[517.895831] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.532s)
[518.017395] [092/133] (533s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[518.107012] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[518.107969] Starting dynamic subtest: pipe-A-eDP-1
[518.117295] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[518.126382] Starting dynamic subtest: pipe-B-eDP-1
[518.135787] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[518.147107] Starting dynamic subtest: pipe-C-eDP-1
[518.157825] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[518.170777] Starting dynamic subtest: pipe-D-eDP-1
[518.181388] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[518.183206] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.007s)
[520.354011] [093/133] (531s left) kms_dirtyfb (default-dirtyfb-ioctl)
[520.451167] Starting subtest: default-dirtyfb-ioctl
[520.452053] Starting dynamic subtest: A-eDP-1
[522.048297] Dynamic subtest A-eDP-1: SUCCESS (1.594s)
[522.049216] Subtest default-dirtyfb-ioctl: SUCCESS (1.596s)
[522.903449] [094/133] (528s left) syncobj_timeline (wait-for-submit-complex)
[522.959575] Starting subtest: wait-for-submit-complex
[523.020934] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[523.104905] [095/133] (528s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[523.216507] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[523.218976] Starting dynamic subtest: pipe-A-eDP-1
[523.658457] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.439s)
[523.669403] Starting dynamic subtest: pipe-B-eDP-1
[523.676974] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.004s)
[523.687818] Starting dynamic subtest: pipe-C-eDP-1
[523.695635] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.005s)
[523.703622] Starting dynamic subtest: pipe-D-eDP-1
[523.711320] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.005s)
[523.712143] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.460s)
[525.950671] [096/133] (525s left) api_intel_allocator (reopen-fork)
[526.012666] Starting subtest: reopen-fork
[529.429331] Subtest reopen-fork: SUCCESS (3.407s)
[529.503176] [097/133] (522s left) kms_plane_multiple (2x-tiling-none)
[529.604812] Starting subtest: 2x-tiling-none
[529.606518] Subtest 2x-tiling-none: SKIP (0.000s)
[529.686999] [098/133] (522s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[529.780525] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[529.781503] Starting dynamic subtest: pipe-A
[530.008890] Dynamic subtest pipe-A: SUCCESS (0.229s)
[530.022698] Starting dynamic subtest: pipe-B
[531.319958] Dynamic subtest pipe-B: SUCCESS (1.310s)
[531.328397] Starting dynamic subtest: pipe-C
[532.656190] Dynamic subtest pipe-C: SUCCESS (1.335s)
[532.666208] Starting dynamic subtest: pipe-D
[533.977539] Dynamic subtest pipe-D: SUCCESS (1.320s)
[533.978435] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.197s)
[535.160550] [099/133] (516s left) kms_atomic (atomic-plane-damage)
[535.260981] Starting subtest: atomic-plane-damage
[535.324643] Starting dynamic subtest: pipe-A-eDP-1
[535.900135] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.575s)
[535.901036] Subtest atomic-plane-damage: SUCCESS (0.640s)
[536.702315] [100/133] (515s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[536.793482] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[543.770176] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.976s)
[543.941288] [101/133] (508s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[544.056545] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[544.058392] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[544.161209] [102/133] (507s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[544.255774] Starting subtest: y-tiled-64bpp-rotate-180
[544.257640] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[544.349568] [103/133] (507s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[544.442702] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[544.443537] Starting dynamic subtest: pipe-A-eDP-1
[544.446707] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[544.454873] Starting dynamic subtest: pipe-B-eDP-1
[544.458230] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[544.468539] Starting dynamic subtest: pipe-C-eDP-1
[544.471992] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[544.482399] Starting dynamic subtest: pipe-D-eDP-1
[544.485539] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[544.487218] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[546.605341] [104/133] (505s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[546.699587] Starting subtest: yf-tiled-32bpp-rotate-180
[546.701548] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[546.810079] [105/133] (505s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[546.898104] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[546.899977] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[547.013564] [106/133] (505s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[547.112997] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[548.224775] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.112s)
[548.391979] [107/133] (503s left) gem_exec_flush (basic-uc-ro-default)
[548.460329] Starting subtest: basic-uc-ro-default
[553.913524] Subtest basic-uc-ro-default: SUCCESS (5.453s)
[554.104666] [108/133] (498s left) kms_color (ctm-green-to-red)
[554.202755] Starting subtest: ctm-green-to-red
[554.203669] Starting dynamic subtest: pipe-A-eDP-1
[554.887752] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.685s)
[554.896250] Starting dynamic subtest: pipe-B-eDP-1
[556.287934] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.399s)
[556.296243] Starting dynamic subtest: pipe-C-eDP-1
[557.685951] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.397s)
[557.694344] Starting dynamic subtest: pipe-D-eDP-1
[558.979183] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.293s)
[558.980069] Subtest ctm-green-to-red: SUCCESS (4.776s)
[559.819801] [109/133] (492s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[559.868500] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all
[559.896746] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.005s)
[560.006763] [110/133] (492s left) syncobj_wait (signal)
[560.049426] Starting subtest: signal
[560.050440] Subtest signal: SUCCESS (0.000s)
[560.175491] [111/133] (492s left) syncobj_wait (wait-all-for-submit-complex)
[560.231256] Starting subtest: wait-all-for-submit-complex
[560.454745] Subtest wait-all-for-submit-complex: SUCCESS (0.214s)
[560.531383] [112/133] (491s left) kms_flip (flip-vs-panning-vs-hang)
[560.620133] Starting subtest: flip-vs-panning-vs-hang
[560.621245] Starting dynamic subtest: A-eDP1
[600.305677] Dynamic subtest A-eDP1: SUCCESS (39.689s)
[600.318956] Starting dynamic subtest: D-eDP1
[650.288760] Dynamic subtest D-eDP1: SUCCESS (49.989s)
[650.291655] Subtest flip-vs-panning-vs-hang: SUCCESS (89.683s)
[651.490878] [113/133] (400s left) kms_addfb_basic (bad-pitch-0)
[651.553144] Starting subtest: bad-pitch-0
[651.554240] Subtest bad-pitch-0: SUCCESS (0.000s)
[651.701072] [114/133] (400s left) gem_userptr_blits (access-control)
[651.769252] Starting subtest: access-control
[651.771053] Subtest access-control: SKIP (0.000s)
[651.914881] [115/133] (400s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[652.001439] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[652.002334] Starting dynamic subtest: pipe-A-eDP-1
[652.023534] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[652.032087] Starting dynamic subtest: pipe-B-eDP-1
[652.052879] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[652.061341] Starting dynamic subtest: pipe-C-eDP-1
[652.081611] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[652.089481] Starting dynamic subtest: pipe-D-eDP-1
[652.110345] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[652.111941] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.009s)
[654.260578] [116/133] (398s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[654.347885] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[654.349586] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[654.470612] [117/133] (398s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[654.564418] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[661.262355] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.696s)
[661.397125] [118/133] (391s left) gem_softpin (noreloc)
[661.454699] Starting subtest: noreloc
[666.889952] Subtest noreloc: SUCCESS (5.388s)
[667.012093] [119/133] (385s left) kms_addfb_basic (bad-pitch-999)
[667.060960] Starting subtest: bad-pitch-999
[667.061810] Subtest bad-pitch-999: SUCCESS (0.000s)
[667.213163] [120/133] (385s left) gem_ctx_create (basic-files)
[667.274779] Starting subtest: basic-files
[669.281972] Subtest basic-files: SUCCESS (2.009s)
[670.903841] [121/133] (381s left) gem_mmap_wc (write-prefaulted)
[670.969516] Subtest write-prefaulted: SKIP (0.000s)
[671.041330] [122/133] (381s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[671.096533] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[671.097959] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[671.211300] [123/133] (381s left) perf_pmu (idle)
[671.253090] Starting subtest: idle
[671.254288] Starting dynamic subtest: rcs0
[671.827750] Dynamic subtest rcs0: SUCCESS (0.563s)
[671.837107] Starting dynamic subtest: bcs0
[672.353427] Dynamic subtest bcs0: SUCCESS (0.522s)
[672.362874] Starting dynamic subtest: vcs0
[672.876371] Dynamic subtest vcs0: SUCCESS (0.521s)
[672.885740] Starting dynamic subtest: vcs1
[673.395905] Dynamic subtest vcs1: SUCCESS (0.516s)
[673.407397] Starting dynamic subtest: vecs0
[673.916559] Dynamic subtest vecs0: SUCCESS (0.518s)
[673.927903] Starting dynamic subtest: ccs0
[674.440738] Dynamic subtest ccs0: SUCCESS (0.521s)
[674.442019] Subtest idle: SUCCESS (3.178s)
[674.542600] [124/133] (378s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[674.640395] Starting subtest: yf-tiled-addfb-size-overflow
[674.642235] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[674.748703] [125/133] (378s left) gem_render_copy_redux (flink)
[674.811849] Starting subtest: flink
[675.511963] Subtest flink: SUCCESS (0.700s)
[675.676487] [126/133] (377s left) gem_busy (semaphore)
[675.860170] Subtest semaphore: SKIP (0.000s)
[676.077865] [127/133] (376s left) i915_pm_freq_api (freq-reset)
[676.129850] Starting subtest: freq-reset
[676.130617] Starting dynamic subtest: gt0
[676.327071] Dynamic subtest gt0: SUCCESS (0.195s)
[676.336644] Starting dynamic subtest: gt1
[676.511494] Dynamic subtest gt1: SUCCESS (0.173s)
[676.512937] Subtest freq-reset: SUCCESS (0.371s)
[676.582303] [128/133] (376s left) gem_ringfill (engines-basic)
[681.810501] Starting subtest: engines-basic
[681.812103] Starting dynamic subtest: rcs0
[681.881492] Dynamic subtest rcs0: SUCCESS (0.077s)
[681.895406] Starting dynamic subtest: bcs0
[681.926312] Dynamic subtest bcs0: SUCCESS (0.043s)
[681.937411] Starting dynamic subtest: vcs0
[681.969530] Dynamic subtest vcs0: SUCCESS (0.041s)
[681.980601] Starting dynamic subtest: vcs1
[682.014167] Dynamic subtest vcs1: SUCCESS (0.043s)
[682.025074] Starting dynamic subtest: vecs0
[682.058393] Dynamic subtest vecs0: SUCCESS (0.042s)
[682.068917] Starting dynamic subtest: ccs0
[682.103403] Dynamic subtest ccs0: SUCCESS (0.043s)
[682.104943] Subtest engines-basic: SUCCESS (0.301s)
[682.194009] [129/133] (370s left) kms_pm_rpm (cursor-dpms)
[683.922019] Starting subtest: cursor-dpms
[683.924480] Subtest cursor-dpms: SKIP (0.000s)
[684.442545] [130/133] (368s left) kms_cursor_crc (cursor-sliding-512x512)
[684.712004] Starting subtest: cursor-sliding-512x512
[684.713726] Subtest cursor-sliding-512x512: SKIP (0.001s)
[684.907972] [131/133] (368s left) syncobj_timeline (etime-multi-wait-submitted)
[684.962051] Starting subtest: etime-multi-wait-submitted
[685.068647] Subtest etime-multi-wait-submitted: SUCCESS (0.105s)
[685.152908] [132/133] (367s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[685.248152] Starting subtest: fbc-rgb565-draw-mmap-wc
[689.329583] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (4.080s)
[690.532543] [133/133] (362s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[690.588610] Starting subtest: multi-wait-all-available-submitted-signaled
[690.589755] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s)
[690.728510] 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.